[17:19:47.278] New invocation is queued and will start shortly
[17:19:48.723] Starting the invocation (attempt 1)
[17:19:48.757] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/30d985e45f9af05ce5d74d770a38d753c71433c1"
[17:19:48.757] Popped gitiles commit info from properties and tags
[17:19:48.757] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:19:48.759] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:19:48.760] Buildbucket request:
{
"requestId": "8854305174911942240",
"builder": {
"project": "chromium-m145",
"bucket": "ci",
"builder": "linux-chromeos-dbg"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8854305174911942240",
"job": "chromium-m145/linux-chromeos-dbg",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d96192cacfdaea044ce0126f3215ca5a4d9e3ad4"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@d96192cacfdaea044ce0126f3215ca5a4d9e3ad4",
"title": "d96192cacfdaea044ce0126f3215ca5a4d9e3ad4",
"url": "https://chromium.googlesource.com/chromium/src/+/d96192cacfdaea044ce0126f3215ca5a4d9e3ad4"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "cb895a6b8c62c1ba5d9c26b1f4758a82ff20aa88"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@cb895a6b8c62c1ba5d9c26b1f4758a82ff20aa88",
"title": "cb895a6b8c62c1ba5d9c26b1f4758a82ff20aa88",
"url": "https://chromium.googlesource.com/chromium/src/+/cb895a6b8c62c1ba5d9c26b1f4758a82ff20aa88"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "36298913113303dde4313002ca77a8b7053febfb"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@36298913113303dde4313002ca77a8b7053febfb",
"title": "36298913113303dde4313002ca77a8b7053febfb",
"url": "https://chromium.googlesource.com/chromium/src/+/36298913113303dde4313002ca77a8b7053febfb"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "78ae78fb4db6f516b52226aa61fe01ddcabd1458"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@78ae78fb4db6f516b52226aa61fe01ddcabd1458",
"title": "78ae78fb4db6f516b52226aa61fe01ddcabd1458",
"url": "https://chromium.googlesource.com/chromium/src/+/78ae78fb4db6f516b52226aa61fe01ddcabd1458"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "bbbed4af101c151e0518751fb340e441b14cbfbf"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@bbbed4af101c151e0518751fb340e441b14cbfbf",
"title": "bbbed4af101c151e0518751fb340e441b14cbfbf",
"url": "https://chromium.googlesource.com/chromium/src/+/bbbed4af101c151e0518751fb340e441b14cbfbf"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e9c357ec123d6cb26252d1d477e31245f981adb0"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@e9c357ec123d6cb26252d1d477e31245f981adb0",
"title": "e9c357ec123d6cb26252d1d477e31245f981adb0",
"url": "https://chromium.googlesource.com/chromium/src/+/e9c357ec123d6cb26252d1d477e31245f981adb0"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "64250bc5c00c7e3eafd171774a1dedb52ee8bfa4"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@64250bc5c00c7e3eafd171774a1dedb52ee8bfa4",
"title": "64250bc5c00c7e3eafd171774a1dedb52ee8bfa4",
"url": "https://chromium.googlesource.com/chromium/src/+/64250bc5c00c7e3eafd171774a1dedb52ee8bfa4"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "62458f13c87ffb74efb9c8747b09e5bb967e44c5"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@62458f13c87ffb74efb9c8747b09e5bb967e44c5",
"title": "62458f13c87ffb74efb9c8747b09e5bb967e44c5",
"url": "https://chromium.googlesource.com/chromium/src/+/62458f13c87ffb74efb9c8747b09e5bb967e44c5"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "30d985e45f9af05ce5d74d770a38d753c71433c1"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@30d985e45f9af05ce5d74d770a38d753c71433c1",
"title": "30d985e45f9af05ce5d74d770a38d753c71433c1",
"url": "https://chromium.googlesource.com/chromium/src/+/30d985e45f9af05ce5d74d770a38d753c71433c1"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "30d985e45f9af05ce5d74d770a38d753c71433c1",
"ref": "refs/branch-heads/7632"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8854305174911942240"
},
{
"key": "scheduler_job_id",
"value": "chromium-m145/linux-chromeos-dbg"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[17:19:49.908] Scheduled build:
{
"id": "8688875112253020433",
"builder": {
"project": "chromium-m145",
"bucket": "ci",
"builder": "linux-chromeos-dbg"
},
"number": 512,
"createdBy": "project:chromium-m145",
"createTime": "2026-02-25T17:19:49.190977546Z",
"updateTime": "2026-02-25T17:19:49.190977546Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "30d985e45f9af05ce5d74d770a38d753c71433c1",
"ref": "refs/branch-heads/7632"
}
}
}
[17:19:49.908] Task URL: https://cr-buildbucket.appspot.com/build/8688875112253020433
[17:19:49.908] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:2:0) after 1m10s
[17:19:50.730] Received PubSub notification, asking Buildbucket for the build status
[17:19:50.750] Build status: SCHEDULED
[17:19:54.944] Received PubSub notification, asking Buildbucket for the build status
[17:19:54.963] Build status: STARTED
[17:20:59.976] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:2:0)
[17:20:59.996] Build status: STARTED
[17:20:59.996] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:5:0) after 3m1s
[17:24:00.976] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:5:0)
[17:24:00.997] Build status: STARTED
[17:24:00.997] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:6:0) after 3m20s
[17:27:20.963] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:6:0)
[17:27:20.979] Build status: STARTED
[17:27:20.979] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:7:0) after 5m18s
[17:32:38.997] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:7:0)
[17:32:39.027] Build status: STARTED
[17:32:39.027] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:8:0) after 2m23s
[17:35:02.043] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:8:0)
[17:35:02.065] Build status: STARTED
[17:35:02.065] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:9:0) after 4m57s
[17:39:59.078] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:9:0)
[17:39:59.124] Build status: STARTED
[17:39:59.124] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:10:0) after 1m28s
[17:41:27.139] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:10:0)
[17:41:27.161] Build status: STARTED
[17:41:27.161] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:11:0) after 3m54s
[17:45:21.175] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:11:0)
[17:45:21.425] Build status: STARTED
[17:45:21.426] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:12:0) after 1m10s
[17:46:31.479] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:12:0)
[17:46:31.502] Build status: STARTED
[17:46:31.502] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:13:0) after 8m16s
[17:54:47.536] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:13:0)
[17:54:47.550] Build status: STARTED
[17:54:47.550] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:14:0) after 9m50s
[18:04:37.612] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:14:0)
[18:04:37.639] Build status: STARTED
[18:04:37.639] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:15:0) after 7m34s
[18:12:11.654] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:15:0)
[18:12:11.671] Build status: STARTED
[18:12:11.671] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:16:0) after 3m53s
[18:16:04.690] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:16:0)
[18:16:04.709] Build status: STARTED
[18:16:04.709] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:17:0) after 7m40s
[18:23:44.773] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:17:0)
[18:23:44.794] Build status: STARTED
[18:23:44.794] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:18:0) after 6m15s
[18:29:59.814] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:18:0)
[18:29:59.887] Build status: STARTED
[18:29:59.887] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:19:0) after 8m22s
[18:38:22.118] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:19:0)
[18:38:22.141] Build status: STARTED
[18:38:22.141] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:20:0) after 4m31s
[18:42:53.333] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:20:0)
[18:42:53.356] Build status: STARTED
[18:42:53.357] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:21:0) after 1m45s
[18:44:38.398] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:21:0)
[18:44:38.427] Build status: STARTED
[18:44:38.427] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:22:0) after 6m47s
[18:51:25.446] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:22:0)
[18:51:25.466] Build status: STARTED
[18:51:25.466] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:23:0) after 4m10s
[18:55:35.642] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:23:0)
[18:55:35.657] Build status: STARTED
[18:55:35.657] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:24:0) after 3m37s
[18:59:12.883] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:24:0)
[18:59:12.906] Build status: STARTED
[18:59:12.906] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:25:0) after 8m2s
[19:07:14.924] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:25:0)
[19:07:14.951] Build status: STARTED
[19:07:14.951] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:26:0) after 4m2s
[19:11:17.073] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:26:0)
[19:11:17.095] Build status: STARTED
[19:11:17.095] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:27:0) after 1m31s
[19:12:48.180] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:27:0)
[19:12:48.204] Build status: STARTED
[19:12:48.204] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:28:0) after 1m38s
[19:14:26.235] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:28:0)
[19:14:26.253] Build status: STARTED
[19:14:26.253] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:29:0) after 1m33s
[19:15:59.319] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:29:0)
[19:15:59.348] Build status: STARTED
[19:15:59.348] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:30:0) after 3m20s
[19:19:19.334] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:30:0)
[19:19:19.352] Build status: STARTED
[19:19:19.352] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:31:0) after 2m39s
[19:21:58.419] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:31:0)
[19:21:58.435] Build status: STARTED
[19:21:58.435] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:32:0) after 8m20s
[19:30:18.457] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:32:0)
[19:30:18.481] Build status: STARTED
[19:30:18.481] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:33:0) after 8m52s
[19:39:10.519] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:33:0)
[19:39:10.567] Build status: STARTED
[19:39:10.567] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:34:0) after 4m27s
[19:43:37.583] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:34:0)
[19:43:37.600] Build status: STARTED
[19:43:37.600] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:35:0) after 3m46s
[19:47:23.768] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:35:0)
[19:47:23.784] Build status: STARTED
[19:47:23.784] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:36:0) after 1m14s
[19:48:37.887] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:36:0)
[19:48:37.910] Build status: STARTED
[19:48:37.910] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:37:0) after 3m26s
[19:52:03.924] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:37:0)
[19:52:03.940] Build status: STARTED
[19:52:03.940] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8854305174911942240:38:0) after 1m32s
[19:53:34.457] Received PubSub notification, asking Buildbucket for the build status
[19:53:34.495] Build:
{
"id": "8688875112253020433",
"builder": {
"project": "chromium-m145",
"bucket": "ci",
"builder": "linux-chromeos-dbg"
},
"number": 512,
"createdBy": "project:chromium-m145",
"createTime": "2026-02-25T17:19:49.190977546Z",
"startTime": "2026-02-25T17:19:54.621623852Z",
"endTime": "2026-02-25T19:53:32.401734054Z",
"updateTime": "2026-02-25T19:53:32.401734054Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "30d985e45f9af05ce5d74d770a38d753c71433c1",
"ref": "refs/branch-heads/7632"
}
}
}
[19:53:34.495] Invocation finished in 2h33m47.223840786s with status FAILED