[12:05:12.670] New invocation is queued and will start shortly
[12:05:13.868] Starting the invocation (attempt 1)
[12:05:13.896] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ee4ffb54b60a5f422a28224c3f718265b7610c1f"
[12:05:13.897] Popped gitiles commit info from properties and tags
[12:05:13.897] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:05:13.897] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:05:13.897] Buildbucket request:
{
"requestId": "8831947515675436752",
"builder": {
"project": "chromium-m156",
"bucket": "ci",
"builder": "linux-chromeos-dbg"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8831947515675436752",
"job": "chromium-m156/linux-chromeos-dbg",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/8078",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b2183b6f84eeeb27990a2568c099cc4955cf56b5"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8078@b2183b6f84eeeb27990a2568c099cc4955cf56b5",
"title": "b2183b6f84eeeb27990a2568c099cc4955cf56b5",
"url": "https://chromium.googlesource.com/chromium/src/+/b2183b6f84eeeb27990a2568c099cc4955cf56b5"
},
{
"gitiles": {
"ref": "refs/branch-heads/8078",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d6ffac22e770c5c013e88b02ba0c68204eb25338"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8078@d6ffac22e770c5c013e88b02ba0c68204eb25338",
"title": "d6ffac22e770c5c013e88b02ba0c68204eb25338",
"url": "https://chromium.googlesource.com/chromium/src/+/d6ffac22e770c5c013e88b02ba0c68204eb25338"
},
{
"gitiles": {
"ref": "refs/branch-heads/8078",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "bab491c5359cfcf13e9ff0d1873abda4ebcba010"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8078@bab491c5359cfcf13e9ff0d1873abda4ebcba010",
"title": "bab491c5359cfcf13e9ff0d1873abda4ebcba010",
"url": "https://chromium.googlesource.com/chromium/src/+/bab491c5359cfcf13e9ff0d1873abda4ebcba010"
},
{
"gitiles": {
"ref": "refs/branch-heads/8078",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a4683580036483245d0d5b033d3e40c9422a2acd"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8078@a4683580036483245d0d5b033d3e40c9422a2acd",
"title": "a4683580036483245d0d5b033d3e40c9422a2acd",
"url": "https://chromium.googlesource.com/chromium/src/+/a4683580036483245d0d5b033d3e40c9422a2acd"
},
{
"gitiles": {
"ref": "refs/branch-heads/8078",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "184f0434026bfa51ae2e72492da495731811c418"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8078@184f0434026bfa51ae2e72492da495731811c418",
"title": "184f0434026bfa51ae2e72492da495731811c418",
"url": "https://chromium.googlesource.com/chromium/src/+/184f0434026bfa51ae2e72492da495731811c418"
},
{
"gitiles": {
"ref": "refs/branch-heads/8078",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "3b89e532750c5b513c05f6343ade1d84ad09841b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8078@3b89e532750c5b513c05f6343ade1d84ad09841b",
"title": "3b89e532750c5b513c05f6343ade1d84ad09841b",
"url": "https://chromium.googlesource.com/chromium/src/+/3b89e532750c5b513c05f6343ade1d84ad09841b"
},
{
"gitiles": {
"ref": "refs/branch-heads/8078",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "9e4f5306883c208a575ed6baffcb72136abc68d3"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8078@9e4f5306883c208a575ed6baffcb72136abc68d3",
"title": "9e4f5306883c208a575ed6baffcb72136abc68d3",
"url": "https://chromium.googlesource.com/chromium/src/+/9e4f5306883c208a575ed6baffcb72136abc68d3"
},
{
"gitiles": {
"ref": "refs/branch-heads/8078",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ee4ffb54b60a5f422a28224c3f718265b7610c1f"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8078@ee4ffb54b60a5f422a28224c3f718265b7610c1f",
"title": "ee4ffb54b60a5f422a28224c3f718265b7610c1f",
"url": "https://chromium.googlesource.com/chromium/src/+/ee4ffb54b60a5f422a28224c3f718265b7610c1f"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "ee4ffb54b60a5f422a28224c3f718265b7610c1f",
"ref": "refs/branch-heads/8078"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8831947515675436752"
},
{
"key": "scheduler_job_id",
"value": "chromium-m156/linux-chromeos-dbg"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[12:05:14.793] Scheduled build:
{
"id": "8666517453625536049",
"builder": {
"project": "chromium-m156",
"bucket": "ci",
"builder": "linux-chromeos-dbg"
},
"number": 324,
"createdBy": "project:chromium-m156",
"createTime": "2026-10-30T12:05:13.998076008Z",
"updateTime": "2026-10-30T12:05:13.998076008Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "ee4ffb54b60a5f422a28224c3f718265b7610c1f",
"ref": "refs/branch-heads/8078"
}
}
}
[12:05:14.794] Task URL: https://cr-buildbucket.appspot.com/build/8666517453625536049
[12:05:14.794] Scheduling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:2:0) after 1m7s
[12:05:15.548] Received PubSub notification, asking Buildbucket for the build status
[12:05:15.566] Build status: SCHEDULED
[12:05:42.963] Received PubSub notification, asking Buildbucket for the build status
[12:05:42.991] Build status: STARTED
[12:06:21.827] Handling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:2:0)
[12:06:21.854] Build status: STARTED
[12:06:21.854] Scheduling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:5:0) after 1m45s
[12:08:06.983] Handling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:5:0)
[12:08:07.015] Build status: STARTED
[12:08:07.015] Scheduling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:6:0) after 5m46s
[12:13:53.063] Handling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:6:0)
[12:13:53.081] Build status: STARTED
[12:13:53.081] Scheduling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:7:0) after 2m40s
[12:16:33.152] Handling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:7:0)
[12:16:33.176] Build status: STARTED
[12:16:33.176] Scheduling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:8:0) after 3m50s
[12:20:23.193] Handling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:8:0)
[12:20:23.228] Build status: STARTED
[12:20:23.228] Scheduling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:9:0) after 2m37s
[12:23:00.271] Handling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:9:0)
[12:23:00.330] Build status: STARTED
[12:23:00.330] Scheduling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:10:0) after 1m27s
[12:24:27.350] Handling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:10:0)
[12:24:27.378] Build status: STARTED
[12:24:27.378] Scheduling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:11:0) after 6m45s
[12:31:12.399] Handling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:11:0)
[12:31:12.855] Build status: STARTED
[12:31:12.855] Scheduling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:12:0) after 9m30s
[12:40:42.937] Handling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:12:0)
[12:40:42.958] Build status: STARTED
[12:40:42.958] Scheduling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:13:0) after 3m29s
[12:44:12.043] Handling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:13:0)
[12:44:12.069] Build status: STARTED
[12:44:12.069] Scheduling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:14:0) after 2m5s
[12:46:17.113] Handling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:14:0)
[12:46:17.152] Build status: STARTED
[12:46:17.152] Scheduling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:15:0) after 2m29s
[12:48:46.171] Handling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:15:0)
[12:48:46.200] Build status: STARTED
[12:48:46.200] Scheduling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:16:0) after 1m59s
[12:50:45.269] Handling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:16:0)
[12:50:45.291] Build status: STARTED
[12:50:45.291] Scheduling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:17:0) after 9m14s
[12:59:59.399] Handling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:17:0)
[12:59:59.429] Build status: STARTED
[12:59:59.429] Scheduling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:18:0) after 3m41s
[13:03:40.442] Handling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:18:0)
[13:03:40.462] Build status: STARTED
[13:03:40.462] Scheduling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:19:0) after 8m54s
[13:12:34.493] Handling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:19:0)
[13:12:34.573] Build status: STARTED
[13:12:34.573] Scheduling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:20:0) after 4m32s
[13:17:06.620] Handling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:20:0)
[13:17:06.653] Build status: STARTED
[13:17:06.653] Scheduling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:21:0) after 1m17s
[13:18:23.634] Handling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:21:0)
[13:18:23.656] Build status: STARTED
[13:18:23.656] Scheduling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:22:0) after 3m23s
[13:21:46.677] Handling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:22:0)
[13:21:46.765] Build status: STARTED
[13:21:46.765] Scheduling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:23:0) after 7m37s
[13:29:23.960] Handling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:23:0)
[13:29:23.979] Build status: STARTED
[13:29:23.979] Scheduling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:24:0) after 7m10s
[13:36:33.999] Handling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:24:0)
[13:36:34.038] Build status: STARTED
[13:36:34.038] Scheduling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:25:0) after 2m42s
[13:39:16.136] Handling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:25:0)
[13:39:16.157] Build status: STARTED
[13:39:16.157] Scheduling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:26:0) after 2m30s
[13:41:46.275] Handling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:26:0)
[13:41:46.320] Build status: STARTED
[13:41:46.320] Scheduling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:27:0) after 8m58s
[13:50:44.392] Handling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:27:0)
[13:50:44.411] Build status: STARTED
[13:50:44.412] Scheduling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:28:0) after 2m1s
[13:52:45.507] Handling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:28:0)
[13:52:45.524] Build status: STARTED
[13:52:45.524] Scheduling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:29:0) after 3m28s
[13:56:13.554] Handling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:29:0)
[13:56:13.571] Build status: STARTED
[13:56:13.571] Scheduling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:30:0) after 1m34s
[13:57:47.644] Handling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:30:0)
[13:57:47.675] Build status: STARTED
[13:57:47.675] Scheduling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:31:0) after 3m36s
[14:01:23.691] Handling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:31:0)
[14:01:23.729] Build status: STARTED
[14:01:23.729] Scheduling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:32:0) after 6m39s
[14:08:02.862] Handling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:32:0)
[14:08:02.900] Build status: STARTED
[14:08:02.900] Scheduling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:33:0) after 7m3s
[14:15:05.921] Handling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:33:0)
[14:15:05.954] Build status: STARTED
[14:15:05.954] Scheduling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:34:0) after 9m7s
[14:24:12.992] Handling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:34:0)
[14:24:13.011] Build status: STARTED
[14:24:13.011] Scheduling timer "check-buildbucket-build-status" (chromium-m156/linux-chromeos-dbg:8831947515675436752:35:0) after 6m19s
[14:25:58.870] Received PubSub notification, asking Buildbucket for the build status
[14:25:58.911] Build:
{
"id": "8666517453625536049",
"builder": {
"project": "chromium-m156",
"bucket": "ci",
"builder": "linux-chromeos-dbg"
},
"number": 324,
"createdBy": "project:chromium-m156",
"createTime": "2026-10-30T12:05:13.998076008Z",
"startTime": "2026-10-30T12:05:42.725899323Z",
"endTime": "2026-10-30T14:25:58.149353204Z",
"updateTime": "2026-10-30T14:25:58.149353204Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "ee4ffb54b60a5f422a28224c3f718265b7610c1f",
"ref": "refs/branch-heads/8078"
}
}
}
[14:25:58.911] Invocation finished in 2h20m46.251579313s with status FAILED