[01:19:48.834] New invocation is queued and will start shortly
[01:19:50.057] Starting the invocation (attempt 1)
[01:19:50.084] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6863baa42d144ef94049cda48cab8570cc2ad8e5"
[01:19:50.084] Popped gitiles commit info from properties and tags
[01:19:50.084] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:19:50.084] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:19:50.085] Buildbucket request:
{
"requestId": "8858080046878106288",
"builder": {
"project": "chromium-m144",
"bucket": "ci",
"builder": "linux-chromeos-dbg"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8858080046878106288",
"job": "chromium-m144/linux-chromeos-dbg",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a5db58b0824120b6640be4bc0ecbc036970868dc"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@a5db58b0824120b6640be4bc0ecbc036970868dc",
"title": "a5db58b0824120b6640be4bc0ecbc036970868dc",
"url": "https://chromium.googlesource.com/chromium/src/+/a5db58b0824120b6640be4bc0ecbc036970868dc"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d3bdce4c4bc4555924e379c1914a53aecc328970"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@d3bdce4c4bc4555924e379c1914a53aecc328970",
"title": "d3bdce4c4bc4555924e379c1914a53aecc328970",
"url": "https://chromium.googlesource.com/chromium/src/+/d3bdce4c4bc4555924e379c1914a53aecc328970"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "056390a224220646eb8c9055c270efebc0a1255d"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@056390a224220646eb8c9055c270efebc0a1255d",
"title": "056390a224220646eb8c9055c270efebc0a1255d",
"url": "https://chromium.googlesource.com/chromium/src/+/056390a224220646eb8c9055c270efebc0a1255d"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "07f4063060a73082195af83b45d89edc032a5911"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@07f4063060a73082195af83b45d89edc032a5911",
"title": "07f4063060a73082195af83b45d89edc032a5911",
"url": "https://chromium.googlesource.com/chromium/src/+/07f4063060a73082195af83b45d89edc032a5911"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "fc22c1ac40e7172ea7cd89e337eadc22f053537b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@fc22c1ac40e7172ea7cd89e337eadc22f053537b",
"title": "fc22c1ac40e7172ea7cd89e337eadc22f053537b",
"url": "https://chromium.googlesource.com/chromium/src/+/fc22c1ac40e7172ea7cd89e337eadc22f053537b"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "fcd363fa2d3b4f176382c71a62aa0ee026be8bab"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@fcd363fa2d3b4f176382c71a62aa0ee026be8bab",
"title": "fcd363fa2d3b4f176382c71a62aa0ee026be8bab",
"url": "https://chromium.googlesource.com/chromium/src/+/fcd363fa2d3b4f176382c71a62aa0ee026be8bab"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "5d552822390ce7212eb7c55c2b51fc81d6ca357c"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@5d552822390ce7212eb7c55c2b51fc81d6ca357c",
"title": "5d552822390ce7212eb7c55c2b51fc81d6ca357c",
"url": "https://chromium.googlesource.com/chromium/src/+/5d552822390ce7212eb7c55c2b51fc81d6ca357c"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "04f4290015f9e6c116be5d5c562e301b04e9e6b1"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@04f4290015f9e6c116be5d5c562e301b04e9e6b1",
"title": "04f4290015f9e6c116be5d5c562e301b04e9e6b1",
"url": "https://chromium.googlesource.com/chromium/src/+/04f4290015f9e6c116be5d5c562e301b04e9e6b1"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "66d7edb94f978b4c9fb20ae2be2a9b0e0a251404"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@66d7edb94f978b4c9fb20ae2be2a9b0e0a251404",
"title": "66d7edb94f978b4c9fb20ae2be2a9b0e0a251404",
"url": "https://chromium.googlesource.com/chromium/src/+/66d7edb94f978b4c9fb20ae2be2a9b0e0a251404"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "48e7e1c3288d08d1c65ccc9ac1be215b43c91f22"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@48e7e1c3288d08d1c65ccc9ac1be215b43c91f22",
"title": "48e7e1c3288d08d1c65ccc9ac1be215b43c91f22",
"url": "https://chromium.googlesource.com/chromium/src/+/48e7e1c3288d08d1c65ccc9ac1be215b43c91f22"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "1fe0b60932391493fe60e913be6c07b1da75bb2d"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@1fe0b60932391493fe60e913be6c07b1da75bb2d",
"title": "1fe0b60932391493fe60e913be6c07b1da75bb2d",
"url": "https://chromium.googlesource.com/chromium/src/+/1fe0b60932391493fe60e913be6c07b1da75bb2d"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "3bd5aba4355e7c438a66ee1d42ebb866c20b5d5e"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@3bd5aba4355e7c438a66ee1d42ebb866c20b5d5e",
"title": "3bd5aba4355e7c438a66ee1d42ebb866c20b5d5e",
"url": "https://chromium.googlesource.com/chromium/src/+/3bd5aba4355e7c438a66ee1d42ebb866c20b5d5e"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "6863baa42d144ef94049cda48cab8570cc2ad8e5"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@6863baa42d144ef94049cda48cab8570cc2ad8e5",
"title": "6863baa42d144ef94049cda48cab8570cc2ad8e5",
"url": "https://chromium.googlesource.com/chromium/src/+/6863baa42d144ef94049cda48cab8570cc2ad8e5"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "6863baa42d144ef94049cda48cab8570cc2ad8e5",
"ref": "refs/branch-heads/7559"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8858080046878106288"
},
{
"key": "scheduler_job_id",
"value": "chromium-m144/linux-chromeos-dbg"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[01:19:50.963] Scheduled build:
{
"id": "8692649984822982449",
"builder": {
"project": "chromium-m144",
"bucket": "ci",
"builder": "linux-chromeos-dbg"
},
"number": 482,
"createdBy": "project:chromium-m144",
"createTime": "2026-01-15T01:19:50.173673144Z",
"updateTime": "2026-01-15T01:19:50.173673144Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "6863baa42d144ef94049cda48cab8570cc2ad8e5",
"ref": "refs/branch-heads/7559"
}
}
}
[01:19:50.963] Task URL: https://cr-buildbucket.appspot.com/build/8692649984822982449
[01:19:50.963] Scheduling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:2:0) after 2m20s
[01:19:51.742] Received PubSub notification, asking Buildbucket for the build status
[01:19:51.762] Build status: SCHEDULED
[01:20:39.093] Received PubSub notification, asking Buildbucket for the build status
[01:20:39.112] Build status: STARTED
[01:22:10.984] Handling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:2:0)
[01:22:11.002] Build status: STARTED
[01:22:11.002] Scheduling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:5:0) after 2m7s
[01:24:18.017] Handling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:5:0)
[01:24:18.097] Build status: STARTED
[01:24:18.097] Scheduling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:6:0) after 8m32s
[01:32:50.175] Handling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:6:0)
[01:32:50.204] Build status: STARTED
[01:32:50.204] Scheduling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:7:0) after 3m30s
[01:36:20.218] Handling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:7:0)
[01:36:20.238] Build status: STARTED
[01:36:20.238] Scheduling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:8:0) after 6m30s
[01:42:50.259] Handling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:8:0)
[01:42:50.272] Build status: STARTED
[01:42:50.272] Scheduling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:9:0) after 1m50s
[01:44:40.287] Handling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:9:0)
[01:44:40.307] Build status: STARTED
[01:44:40.307] Scheduling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:10:0) after 9m36s
[01:54:16.321] Handling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:10:0)
[01:54:16.344] Build status: STARTED
[01:54:16.344] Scheduling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:11:0) after 1m34s
[01:55:50.414] Handling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:11:0)
[01:55:50.482] Build status: STARTED
[01:55:50.482] Scheduling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:12:0) after 8m30s
[02:04:20.570] Handling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:12:0)
[02:04:20.614] Build status: STARTED
[02:04:20.614] Scheduling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:13:0) after 1m7s
[02:05:27.630] Handling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:13:0)
[02:05:27.708] Build status: STARTED
[02:05:27.708] Scheduling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:14:0) after 9m49s
[02:15:16.781] Handling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:14:0)
[02:15:16.794] Build status: STARTED
[02:15:16.794] Scheduling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:15:0) after 8m18s
[02:23:34.947] Handling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:15:0)
[02:23:34.965] Build status: STARTED
[02:23:34.965] Scheduling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:16:0) after 4m53s
[02:28:28.197] Handling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:16:0)
[02:28:28.226] Build status: STARTED
[02:28:28.226] Scheduling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:17:0) after 7m46s
[02:36:14.242] Handling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:17:0)
[02:36:14.308] Build status: STARTED
[02:36:14.308] Scheduling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:18:0) after 2m21s
[02:38:35.331] Handling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:18:0)
[02:38:35.349] Build status: STARTED
[02:38:35.349] Scheduling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:19:0) after 7m13s
[02:45:48.337] Handling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:19:0)
[02:45:48.354] Build status: STARTED
[02:45:48.354] Scheduling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:20:0) after 4m16s
[02:50:04.369] Handling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:20:0)
[02:50:04.421] Build status: STARTED
[02:50:04.421] Scheduling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:21:0) after 2m8s
[02:52:12.442] Handling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:21:0)
[02:52:12.462] Build status: STARTED
[02:52:12.462] Scheduling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:22:0) after 9m40s
[03:01:52.627] Handling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:22:0)
[03:01:52.641] Build status: STARTED
[03:01:52.641] Scheduling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:23:0) after 9m54s
[03:11:46.772] Handling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:23:0)
[03:11:46.788] Build status: STARTED
[03:11:46.788] Scheduling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:24:0) after 8m55s
[03:20:41.937] Handling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:24:0)
[03:20:41.953] Build status: STARTED
[03:20:41.953] Scheduling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:25:0) after 7m17s
[03:27:59.288] Handling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:25:0)
[03:27:59.339] Build status: STARTED
[03:27:59.339] Scheduling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:26:0) after 6m39s
[03:34:38.459] Handling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:26:0)
[03:34:38.474] Build status: STARTED
[03:34:38.474] Scheduling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:27:0) after 4m34s
[03:39:12.582] Handling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:27:0)
[03:39:12.657] Build status: STARTED
[03:39:12.657] Scheduling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:28:0) after 7m2s
[03:46:14.810] Handling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:28:0)
[03:46:14.829] Build status: STARTED
[03:46:14.829] Scheduling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:29:0) after 5m58s
[03:52:12.852] Handling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:29:0)
[03:52:12.868] Build status: STARTED
[03:52:12.868] Scheduling timer "check-buildbucket-build-status" (chromium-m144/linux-chromeos-dbg:8858080046878106288:30:0) after 8m12s
[03:53:05.356] Received PubSub notification, asking Buildbucket for the build status
[03:53:05.377] Build:
{
"id": "8692649984822982449",
"builder": {
"project": "chromium-m144",
"bucket": "ci",
"builder": "linux-chromeos-dbg"
},
"number": 482,
"createdBy": "project:chromium-m144",
"createTime": "2026-01-15T01:19:50.173673144Z",
"startTime": "2026-01-15T01:20:38.765019538Z",
"endTime": "2026-01-15T03:53:05.032654900Z",
"updateTime": "2026-01-15T03:53:05.032654900Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "6863baa42d144ef94049cda48cab8570cc2ad8e5",
"ref": "refs/branch-heads/7559"
}
}
}
[03:53:05.377] Invocation finished in 2h33m16.54814238s with status FAILED