[17:12:48.731] New invocation is queued and will start shortly
[17:12:50.530] Starting the invocation (attempt 1)
[17:12:50.556] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/38d1aaf0e4e212ac7a49a1afc5a26d2567963a49"
[17:12:50.556] Popped gitiles commit info from properties and tags
[17:12:50.556] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:12:50.557] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:12:50.557] Buildbucket request:
{
"requestId": "8839719502197457664",
"builder": {
"project": "chromium-m152",
"bucket": "ci",
"builder": "linux-chromeos-dbg"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8839719502197457664",
"job": "chromium-m152/linux-chromeos-dbg",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7977",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a18c4219bd60902ab04ea202fdc25b0e9b3936b1"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7977@a18c4219bd60902ab04ea202fdc25b0e9b3936b1",
"title": "a18c4219bd60902ab04ea202fdc25b0e9b3936b1",
"url": "https://chromium.googlesource.com/chromium/src/+/a18c4219bd60902ab04ea202fdc25b0e9b3936b1"
},
{
"gitiles": {
"ref": "refs/branch-heads/7977",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "bf8580ce540dc88b76e146ccc7fe8bb84eb28c71"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7977@bf8580ce540dc88b76e146ccc7fe8bb84eb28c71",
"title": "bf8580ce540dc88b76e146ccc7fe8bb84eb28c71",
"url": "https://chromium.googlesource.com/chromium/src/+/bf8580ce540dc88b76e146ccc7fe8bb84eb28c71"
},
{
"gitiles": {
"ref": "refs/branch-heads/7977",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "1984c04cefdaff73237ba75e4f8589686b8f42ab"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7977@1984c04cefdaff73237ba75e4f8589686b8f42ab",
"title": "1984c04cefdaff73237ba75e4f8589686b8f42ab",
"url": "https://chromium.googlesource.com/chromium/src/+/1984c04cefdaff73237ba75e4f8589686b8f42ab"
},
{
"gitiles": {
"ref": "refs/branch-heads/7977",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "480a7b56933334dff2dc896b47675dc35b358069"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7977@480a7b56933334dff2dc896b47675dc35b358069",
"title": "480a7b56933334dff2dc896b47675dc35b358069",
"url": "https://chromium.googlesource.com/chromium/src/+/480a7b56933334dff2dc896b47675dc35b358069"
},
{
"gitiles": {
"ref": "refs/branch-heads/7977",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "24f6e98b5cd0d55527db5b98ca17ddc5c9ea6614"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7977@24f6e98b5cd0d55527db5b98ca17ddc5c9ea6614",
"title": "24f6e98b5cd0d55527db5b98ca17ddc5c9ea6614",
"url": "https://chromium.googlesource.com/chromium/src/+/24f6e98b5cd0d55527db5b98ca17ddc5c9ea6614"
},
{
"gitiles": {
"ref": "refs/branch-heads/7977",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "92106de50471fd7d1224bbe1f7f3a5e5a02fe611"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7977@92106de50471fd7d1224bbe1f7f3a5e5a02fe611",
"title": "92106de50471fd7d1224bbe1f7f3a5e5a02fe611",
"url": "https://chromium.googlesource.com/chromium/src/+/92106de50471fd7d1224bbe1f7f3a5e5a02fe611"
},
{
"gitiles": {
"ref": "refs/branch-heads/7977",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "40a40ae3e066fc66f1c00fcd723c0638a5ff8464"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7977@40a40ae3e066fc66f1c00fcd723c0638a5ff8464",
"title": "40a40ae3e066fc66f1c00fcd723c0638a5ff8464",
"url": "https://chromium.googlesource.com/chromium/src/+/40a40ae3e066fc66f1c00fcd723c0638a5ff8464"
},
{
"gitiles": {
"ref": "refs/branch-heads/7977",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "af940b4a3902eed30b5097ac4b0364d30ac6ec16"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7977@af940b4a3902eed30b5097ac4b0364d30ac6ec16",
"title": "af940b4a3902eed30b5097ac4b0364d30ac6ec16",
"url": "https://chromium.googlesource.com/chromium/src/+/af940b4a3902eed30b5097ac4b0364d30ac6ec16"
},
{
"gitiles": {
"ref": "refs/branch-heads/7977",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "63fa9882821007ac2ca62bdaf95417e7624c18d5"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7977@63fa9882821007ac2ca62bdaf95417e7624c18d5",
"title": "63fa9882821007ac2ca62bdaf95417e7624c18d5",
"url": "https://chromium.googlesource.com/chromium/src/+/63fa9882821007ac2ca62bdaf95417e7624c18d5"
},
{
"gitiles": {
"ref": "refs/branch-heads/7977",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "5c7542a10b949fe2561b839813be172f82d8cf4a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7977@5c7542a10b949fe2561b839813be172f82d8cf4a",
"title": "5c7542a10b949fe2561b839813be172f82d8cf4a",
"url": "https://chromium.googlesource.com/chromium/src/+/5c7542a10b949fe2561b839813be172f82d8cf4a"
},
{
"gitiles": {
"ref": "refs/branch-heads/7977",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "38d1aaf0e4e212ac7a49a1afc5a26d2567963a49"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7977@38d1aaf0e4e212ac7a49a1afc5a26d2567963a49",
"title": "38d1aaf0e4e212ac7a49a1afc5a26d2567963a49",
"url": "https://chromium.googlesource.com/chromium/src/+/38d1aaf0e4e212ac7a49a1afc5a26d2567963a49"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "38d1aaf0e4e212ac7a49a1afc5a26d2567963a49",
"ref": "refs/branch-heads/7977"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8839719502197457664"
},
{
"key": "scheduler_job_id",
"value": "chromium-m152/linux-chromeos-dbg"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[17:12:51.337] Scheduled build:
{
"id": "8674289439551151713",
"builder": {
"project": "chromium-m152",
"bucket": "ci",
"builder": "linux-chromeos-dbg"
},
"number": 100,
"createdBy": "project:chromium-m152",
"createTime": "2026-08-05T17:12:50.634737912Z",
"updateTime": "2026-08-05T17:12:50.634737912Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "38d1aaf0e4e212ac7a49a1afc5a26d2567963a49",
"ref": "refs/branch-heads/7977"
}
}
}
[17:12:51.337] Task URL: https://cr-buildbucket.appspot.com/build/8674289439551151713
[17:12:51.337] Scheduling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:2:0) after 8m23s
[17:12:51.424] Received PubSub notification, asking Buildbucket for the build status
[17:12:51.447] Build status: SCHEDULED
[17:13:57.546] Received PubSub notification, asking Buildbucket for the build status
[17:13:57.565] Build status: STARTED
[17:21:14.403] Handling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:2:0)
[17:21:14.438] Build status: STARTED
[17:21:14.438] Scheduling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:5:0) after 2m23s
[17:23:37.449] Handling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:5:0)
[17:23:37.467] Build status: STARTED
[17:23:37.467] Scheduling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:6:0) after 3m23s
[17:27:00.486] Handling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:6:0)
[17:27:00.503] Build status: STARTED
[17:27:00.503] Scheduling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:7:0) after 6m31s
[17:33:31.754] Handling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:7:0)
[17:33:31.775] Build status: STARTED
[17:33:31.775] Scheduling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:8:0) after 5m32s
[17:39:03.832] Handling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:8:0)
[17:39:03.864] Build status: STARTED
[17:39:03.864] Scheduling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:9:0) after 7m20s
[17:46:23.901] Handling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:9:0)
[17:46:23.919] Build status: STARTED
[17:46:23.919] Scheduling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:10:0) after 4m18s
[17:50:42.073] Handling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:10:0)
[17:50:42.124] Build status: STARTED
[17:50:42.124] Scheduling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:11:0) after 3m3s
[17:53:45.307] Handling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:11:0)
[17:53:45.329] Build status: STARTED
[17:53:45.329] Scheduling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:12:0) after 9m28s
[18:03:13.434] Handling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:12:0)
[18:03:13.453] Build status: STARTED
[18:03:13.453] Scheduling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:13:0) after 2m16s
[18:05:29.505] Handling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:13:0)
[18:05:29.548] Build status: STARTED
[18:05:29.548] Scheduling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:14:0) after 8m42s
[18:14:11.944] Handling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:14:0)
[18:14:12.057] Build status: STARTED
[18:14:12.057] Scheduling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:15:0) after 4m28s
[18:18:40.073] Handling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:15:0)
[18:18:40.093] Build status: STARTED
[18:18:40.093] Scheduling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:16:0) after 4m31s
[18:23:11.109] Handling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:16:0)
[18:23:11.139] Build status: STARTED
[18:23:11.139] Scheduling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:17:0) after 2m35s
[18:25:46.159] Handling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:17:0)
[18:25:46.176] Build status: STARTED
[18:25:46.176] Scheduling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:18:0) after 5m4s
[18:30:50.198] Handling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:18:0)
[18:30:50.244] Build status: STARTED
[18:30:50.244] Scheduling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:19:0) after 1m35s
[18:32:25.258] Handling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:19:0)
[18:32:25.305] Build status: STARTED
[18:32:25.305] Scheduling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:20:0) after 9m3s
[18:41:28.324] Handling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:20:0)
[18:41:28.355] Build status: STARTED
[18:41:28.355] Scheduling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:21:0) after 8m11s
[18:49:39.396] Handling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:21:0)
[18:49:39.414] Build status: STARTED
[18:49:39.414] Scheduling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:22:0) after 2m23s
[18:52:02.445] Handling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:22:0)
[18:52:02.464] Build status: STARTED
[18:52:02.464] Scheduling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:23:0) after 5m17s
[18:57:19.440] Handling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:23:0)
[18:57:19.458] Build status: STARTED
[18:57:19.458] Scheduling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:24:0) after 5m17s
[19:02:36.508] Handling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:24:0)
[19:02:36.538] Build status: STARTED
[19:02:36.538] Scheduling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:25:0) after 2m29s
[19:05:05.554] Handling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:25:0)
[19:05:05.590] Build status: STARTED
[19:05:05.590] Scheduling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:26:0) after 2m46s
[19:07:51.576] Handling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:26:0)
[19:07:51.598] Build status: STARTED
[19:07:51.598] Scheduling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:27:0) after 8m13s
[19:16:04.730] Handling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:27:0)
[19:16:04.752] Build status: STARTED
[19:16:04.752] Scheduling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:28:0) after 7m9s
[19:23:13.933] Handling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:28:0)
[19:23:13.956] Build status: STARTED
[19:23:13.956] Scheduling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:29:0) after 8m17s
[19:31:31.191] Handling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:29:0)
[19:31:31.222] Build status: STARTED
[19:31:31.222] Scheduling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:30:0) after 5m59s
[19:37:30.265] Handling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:30:0)
[19:37:30.312] Build status: STARTED
[19:37:30.312] Scheduling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:31:0) after 6m32s
[19:44:02.291] Handling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:31:0)
[19:44:02.307] Build status: STARTED
[19:44:02.307] Scheduling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:32:0) after 2m25s
[19:46:27.283] Handling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:32:0)
[19:46:27.300] Build status: STARTED
[19:46:27.300] Scheduling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:33:0) after 4m16s
[19:50:43.318] Handling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:33:0)
[19:50:43.337] Build status: STARTED
[19:50:43.337] Scheduling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:34:0) after 8m42s
[19:59:25.352] Handling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:34:0)
[19:59:25.379] Build status: STARTED
[19:59:25.379] Scheduling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:35:0) after 3m56s
[20:03:21.504] Handling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:35:0)
[20:03:21.522] Build status: STARTED
[20:03:21.522] Scheduling timer "check-buildbucket-build-status" (chromium-m152/linux-chromeos-dbg:8839719502197457664:36:0) after 4m22s
[20:05:45.607] Received PubSub notification, asking Buildbucket for the build status
[20:05:45.638] Build:
{
"id": "8674289439551151713",
"builder": {
"project": "chromium-m152",
"bucket": "ci",
"builder": "linux-chromeos-dbg"
},
"number": 100,
"createdBy": "project:chromium-m152",
"createTime": "2026-08-05T17:12:50.634737912Z",
"startTime": "2026-08-05T17:13:57.232135140Z",
"endTime": "2026-08-05T20:05:45.069769327Z",
"updateTime": "2026-08-05T20:05:45.069769327Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "38d1aaf0e4e212ac7a49a1afc5a26d2567963a49",
"ref": "refs/branch-heads/7977"
}
}
}
[20:05:45.638] Invocation finished in 2h52m56.911523923s with status FAILED