[19:49:45.604] New invocation is queued and will start shortly
[19:49:46.930] Starting the invocation (attempt 1)
[19:49:46.958] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d10f182e5b18c5641f805a27990973ffa0ec1da4"
[19:49:46.958] Popped gitiles commit info from properties and tags
[19:49:46.958] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:49:46.958] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:49:46.958] Buildbucket request:
{
"requestId": "8836357540138228304",
"builder": {
"project": "chromium-m154",
"bucket": "ci",
"builder": "linux-chromeos-dbg"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8836357540138228304",
"job": "chromium-m154/linux-chromeos-dbg",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/8037",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "9f8133c63233fa0f82b6fe3b1b0cb389f7b0a1b7"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8037@9f8133c63233fa0f82b6fe3b1b0cb389f7b0a1b7",
"title": "9f8133c63233fa0f82b6fe3b1b0cb389f7b0a1b7",
"url": "https://chromium.googlesource.com/chromium/src/+/9f8133c63233fa0f82b6fe3b1b0cb389f7b0a1b7"
},
{
"gitiles": {
"ref": "refs/branch-heads/8037",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "bc2fd362b085d36838505276c28dfff210bee9c6"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8037@bc2fd362b085d36838505276c28dfff210bee9c6",
"title": "bc2fd362b085d36838505276c28dfff210bee9c6",
"url": "https://chromium.googlesource.com/chromium/src/+/bc2fd362b085d36838505276c28dfff210bee9c6"
},
{
"gitiles": {
"ref": "refs/branch-heads/8037",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "69ac139d186d66e71c8e0398d7e5f58164d66878"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8037@69ac139d186d66e71c8e0398d7e5f58164d66878",
"title": "69ac139d186d66e71c8e0398d7e5f58164d66878",
"url": "https://chromium.googlesource.com/chromium/src/+/69ac139d186d66e71c8e0398d7e5f58164d66878"
},
{
"gitiles": {
"ref": "refs/branch-heads/8037",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "539edee101373a6f9989d0359af1e6986202addf"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8037@539edee101373a6f9989d0359af1e6986202addf",
"title": "539edee101373a6f9989d0359af1e6986202addf",
"url": "https://chromium.googlesource.com/chromium/src/+/539edee101373a6f9989d0359af1e6986202addf"
},
{
"gitiles": {
"ref": "refs/branch-heads/8037",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "9766bcb3dac78d53e8287c85ea851288319b9085"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8037@9766bcb3dac78d53e8287c85ea851288319b9085",
"title": "9766bcb3dac78d53e8287c85ea851288319b9085",
"url": "https://chromium.googlesource.com/chromium/src/+/9766bcb3dac78d53e8287c85ea851288319b9085"
},
{
"gitiles": {
"ref": "refs/branch-heads/8037",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0244ce9c0dc9a00a0350466fc43e9fa27b763bcd"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8037@0244ce9c0dc9a00a0350466fc43e9fa27b763bcd",
"title": "0244ce9c0dc9a00a0350466fc43e9fa27b763bcd",
"url": "https://chromium.googlesource.com/chromium/src/+/0244ce9c0dc9a00a0350466fc43e9fa27b763bcd"
},
{
"gitiles": {
"ref": "refs/branch-heads/8037",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "1eea0f322a63c2eb4cea8d01c227ba742dc7a5ef"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8037@1eea0f322a63c2eb4cea8d01c227ba742dc7a5ef",
"title": "1eea0f322a63c2eb4cea8d01c227ba742dc7a5ef",
"url": "https://chromium.googlesource.com/chromium/src/+/1eea0f322a63c2eb4cea8d01c227ba742dc7a5ef"
},
{
"gitiles": {
"ref": "refs/branch-heads/8037",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "fc62275f2733766240d865f1d850a3987784b5a7"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8037@fc62275f2733766240d865f1d850a3987784b5a7",
"title": "fc62275f2733766240d865f1d850a3987784b5a7",
"url": "https://chromium.googlesource.com/chromium/src/+/fc62275f2733766240d865f1d850a3987784b5a7"
},
{
"gitiles": {
"ref": "refs/branch-heads/8037",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "98b31ed7e300b9ee17ea40eb6d520d953f8987c5"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8037@98b31ed7e300b9ee17ea40eb6d520d953f8987c5",
"title": "98b31ed7e300b9ee17ea40eb6d520d953f8987c5",
"url": "https://chromium.googlesource.com/chromium/src/+/98b31ed7e300b9ee17ea40eb6d520d953f8987c5"
},
{
"gitiles": {
"ref": "refs/branch-heads/8037",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "930f9d1fb115466d17236013cb350bce48d67b14"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8037@930f9d1fb115466d17236013cb350bce48d67b14",
"title": "930f9d1fb115466d17236013cb350bce48d67b14",
"url": "https://chromium.googlesource.com/chromium/src/+/930f9d1fb115466d17236013cb350bce48d67b14"
},
{
"gitiles": {
"ref": "refs/branch-heads/8037",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "3bb735ef64223baa2d986bd17f2ae41a0329acd2"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8037@3bb735ef64223baa2d986bd17f2ae41a0329acd2",
"title": "3bb735ef64223baa2d986bd17f2ae41a0329acd2",
"url": "https://chromium.googlesource.com/chromium/src/+/3bb735ef64223baa2d986bd17f2ae41a0329acd2"
},
{
"gitiles": {
"ref": "refs/branch-heads/8037",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b98ecc1a0aef21a3642bfc939f31f79fd5f8e095"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8037@b98ecc1a0aef21a3642bfc939f31f79fd5f8e095",
"title": "b98ecc1a0aef21a3642bfc939f31f79fd5f8e095",
"url": "https://chromium.googlesource.com/chromium/src/+/b98ecc1a0aef21a3642bfc939f31f79fd5f8e095"
},
{
"gitiles": {
"ref": "refs/branch-heads/8037",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d10f182e5b18c5641f805a27990973ffa0ec1da4"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8037@d10f182e5b18c5641f805a27990973ffa0ec1da4",
"title": "d10f182e5b18c5641f805a27990973ffa0ec1da4",
"url": "https://chromium.googlesource.com/chromium/src/+/d10f182e5b18c5641f805a27990973ffa0ec1da4"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d10f182e5b18c5641f805a27990973ffa0ec1da4",
"ref": "refs/branch-heads/8037"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8836357540138228304"
},
{
"key": "scheduler_job_id",
"value": "chromium-m154/linux-chromeos-dbg"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[19:49:47.575] Scheduled build:
{
"id": "8670927477960729185",
"builder": {
"project": "chromium-m154",
"bucket": "ci",
"builder": "linux-chromeos-dbg"
},
"number": 103,
"createdBy": "project:chromium-m154",
"createTime": "2026-09-11T19:49:47.055711379Z",
"updateTime": "2026-09-11T19:49:47.055711379Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d10f182e5b18c5641f805a27990973ffa0ec1da4",
"ref": "refs/branch-heads/8037"
}
}
}
[19:49:47.575] Task URL: https://cr-buildbucket.appspot.com/build/8670927477960729185
[19:49:47.575] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:2:0) after 9m5s
[19:49:48.588] Received PubSub notification, asking Buildbucket for the build status
[19:49:48.639] Build status: SCHEDULED
[19:49:51.844] Received PubSub notification, asking Buildbucket for the build status
[19:49:51.867] Build status: STARTED
[19:58:52.762] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:2:0)
[19:58:52.786] Build status: STARTED
[19:58:52.786] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:5:0) after 7m53s
[20:06:45.903] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:5:0)
[20:06:45.931] Build status: STARTED
[20:06:45.931] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:6:0) after 7m30s
[20:14:15.946] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:6:0)
[20:14:15.971] Build status: STARTED
[20:14:15.972] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:7:0) after 7m20s
[20:21:36.016] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:7:0)
[20:21:36.038] Build status: STARTED
[20:21:36.038] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:8:0) after 4m51s
[20:26:27.054] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:8:0)
[20:26:27.080] Build status: STARTED
[20:26:27.080] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:9:0) after 1m49s
[20:28:16.185] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:9:0)
[20:28:16.259] Build status: STARTED
[20:28:16.259] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:10:0) after 5m34s
[20:33:50.300] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:10:0)
[20:33:50.323] Build status: STARTED
[20:33:50.323] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:11:0) after 2m41s
[20:36:31.365] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:11:0)
[20:36:31.397] Build status: STARTED
[20:36:31.397] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:12:0) after 3m39s
[20:40:10.462] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:12:0)
[20:40:10.481] Build status: STARTED
[20:40:10.481] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:13:0) after 8m18s
[20:48:28.563] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:13:0)
[20:48:28.594] Build status: STARTED
[20:48:28.594] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:14:0) after 1m22s
[20:49:50.671] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:14:0)
[20:49:50.695] Build status: STARTED
[20:49:50.695] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:15:0) after 4m14s
[20:54:04.689] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:15:0)
[20:54:04.731] Build status: STARTED
[20:54:04.731] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:16:0) after 9m40s
[21:03:44.779] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:16:0)
[21:03:44.799] Build status: STARTED
[21:03:44.799] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:17:0) after 9m23s
[21:13:08.002] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:17:0)
[21:13:08.020] Build status: STARTED
[21:13:08.020] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:18:0) after 7m36s
[21:20:44.042] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:18:0)
[21:20:44.258] Build status: STARTED
[21:20:44.258] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:19:0) after 9m38s
[21:30:22.277] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:19:0)
[21:30:22.300] Build status: STARTED
[21:30:22.301] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:20:0) after 5m0s
[21:35:22.450] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:20:0)
[21:35:22.474] Build status: STARTED
[21:35:22.474] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:21:0) after 1m26s
[21:36:48.542] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:21:0)
[21:36:48.568] Build status: STARTED
[21:36:48.568] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:22:0) after 7m9s
[21:43:57.587] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:22:0)
[21:43:57.604] Build status: STARTED
[21:43:57.604] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:23:0) after 5m9s
[21:49:06.620] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:23:0)
[21:49:06.637] Build status: STARTED
[21:49:06.637] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:24:0) after 5m35s
[21:54:41.656] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:24:0)
[21:54:41.675] Build status: STARTED
[21:54:41.675] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:25:0) after 4m56s
[21:59:37.700] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:25:0)
[21:59:37.719] Build status: STARTED
[21:59:37.719] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:26:0) after 7m17s
[22:06:54.772] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:26:0)
[22:06:54.976] Build status: STARTED
[22:06:54.976] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:27:0) after 1m12s
[22:08:06.960] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:27:0)
[22:08:06.994] Build status: STARTED
[22:08:06.994] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:28:0) after 1m5s
[22:09:12.070] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:28:0)
[22:09:12.142] Build status: STARTED
[22:09:12.142] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:29:0) after 9m42s
[22:18:54.220] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:29:0)
[22:18:54.246] Build status: STARTED
[22:18:54.246] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:30:0) after 2m7s
[22:21:01.241] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:30:0)
[22:21:01.265] Build status: STARTED
[22:21:01.265] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-chromeos-dbg:8836357540138228304:31:0) after 5m54s
[22:23:37.791] Received PubSub notification, asking Buildbucket for the build status
[22:23:37.811] Build:
{
"id": "8670927477960729185",
"builder": {
"project": "chromium-m154",
"bucket": "ci",
"builder": "linux-chromeos-dbg"
},
"number": 103,
"createdBy": "project:chromium-m154",
"createTime": "2026-09-11T19:49:47.055711379Z",
"startTime": "2026-09-11T19:49:51.365000429Z",
"endTime": "2026-09-11T22:23:37.127168136Z",
"updateTime": "2026-09-11T22:23:37.127168136Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d10f182e5b18c5641f805a27990973ffa0ec1da4",
"ref": "refs/branch-heads/8037"
}
}
}
[22:23:37.811] Invocation finished in 2h33m52.2163745s with status FAILED