[05:08:38.976] New invocation is queued and will start shortly
[05:08:40.152] Starting the invocation (attempt 1)
[05:08:40.177] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d4db4638bf522afc31d5b0bb905d99c5b83384c9"
[05:08:40.177] Popped gitiles commit info from properties and tags
[05:08:40.177] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:08:40.177] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:08:40.178] Buildbucket request:
{
"requestId": "8855347740789145248",
"builder": {
"project": "chromium-m145",
"bucket": "ci",
"builder": "win-official"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8855347740789145248",
"job": "chromium-m145/win-official",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "33cca05101cad0a7133808fe3d3d12e9f80a95d8"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@33cca05101cad0a7133808fe3d3d12e9f80a95d8",
"title": "33cca05101cad0a7133808fe3d3d12e9f80a95d8",
"url": "https://chromium.googlesource.com/chromium/src/+/33cca05101cad0a7133808fe3d3d12e9f80a95d8"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4087328fbfdc6073e1fcc9fa5eeba4830fee3853"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@4087328fbfdc6073e1fcc9fa5eeba4830fee3853",
"title": "4087328fbfdc6073e1fcc9fa5eeba4830fee3853",
"url": "https://chromium.googlesource.com/chromium/src/+/4087328fbfdc6073e1fcc9fa5eeba4830fee3853"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c14c293849ec0411c3e93939018bf8d8175b99d3"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@c14c293849ec0411c3e93939018bf8d8175b99d3",
"title": "c14c293849ec0411c3e93939018bf8d8175b99d3",
"url": "https://chromium.googlesource.com/chromium/src/+/c14c293849ec0411c3e93939018bf8d8175b99d3"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "3240e5d4f3213b1b5bf4899cdea23656c4543e12"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@3240e5d4f3213b1b5bf4899cdea23656c4543e12",
"title": "3240e5d4f3213b1b5bf4899cdea23656c4543e12",
"url": "https://chromium.googlesource.com/chromium/src/+/3240e5d4f3213b1b5bf4899cdea23656c4543e12"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c3b0626b363708ace9fd649d7f65f7bb6a9df7ce"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@c3b0626b363708ace9fd649d7f65f7bb6a9df7ce",
"title": "c3b0626b363708ace9fd649d7f65f7bb6a9df7ce",
"url": "https://chromium.googlesource.com/chromium/src/+/c3b0626b363708ace9fd649d7f65f7bb6a9df7ce"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b75b1642c4e7f7f558b6e30c30141e931b2b84e4"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@b75b1642c4e7f7f558b6e30c30141e931b2b84e4",
"title": "b75b1642c4e7f7f558b6e30c30141e931b2b84e4",
"url": "https://chromium.googlesource.com/chromium/src/+/b75b1642c4e7f7f558b6e30c30141e931b2b84e4"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "835fed531bfa5b8977e3937642bd9d75eac16abf"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@835fed531bfa5b8977e3937642bd9d75eac16abf",
"title": "835fed531bfa5b8977e3937642bd9d75eac16abf",
"url": "https://chromium.googlesource.com/chromium/src/+/835fed531bfa5b8977e3937642bd9d75eac16abf"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4b47fd1a983ae28d29bcec156e0e4300253faa27"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@4b47fd1a983ae28d29bcec156e0e4300253faa27",
"title": "4b47fd1a983ae28d29bcec156e0e4300253faa27",
"url": "https://chromium.googlesource.com/chromium/src/+/4b47fd1a983ae28d29bcec156e0e4300253faa27"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "f8bfb361bd8143d0502f3babc3b463beaef46f4b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@f8bfb361bd8143d0502f3babc3b463beaef46f4b",
"title": "f8bfb361bd8143d0502f3babc3b463beaef46f4b",
"url": "https://chromium.googlesource.com/chromium/src/+/f8bfb361bd8143d0502f3babc3b463beaef46f4b"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "cf6b02bf4b1567494d12f05509edceee55dd4381"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@cf6b02bf4b1567494d12f05509edceee55dd4381",
"title": "cf6b02bf4b1567494d12f05509edceee55dd4381",
"url": "https://chromium.googlesource.com/chromium/src/+/cf6b02bf4b1567494d12f05509edceee55dd4381"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "5a7d3b1f82d25485443c379c8c01adce910a503c"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@5a7d3b1f82d25485443c379c8c01adce910a503c",
"title": "5a7d3b1f82d25485443c379c8c01adce910a503c",
"url": "https://chromium.googlesource.com/chromium/src/+/5a7d3b1f82d25485443c379c8c01adce910a503c"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "40320669ce350797a01ba3cc7c6fcfc883d07e89"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@40320669ce350797a01ba3cc7c6fcfc883d07e89",
"title": "40320669ce350797a01ba3cc7c6fcfc883d07e89",
"url": "https://chromium.googlesource.com/chromium/src/+/40320669ce350797a01ba3cc7c6fcfc883d07e89"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "67b307f91d1b0165d31e167d847157983b04cf03"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@67b307f91d1b0165d31e167d847157983b04cf03",
"title": "67b307f91d1b0165d31e167d847157983b04cf03",
"url": "https://chromium.googlesource.com/chromium/src/+/67b307f91d1b0165d31e167d847157983b04cf03"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0601100a0fc3d9bf07d9935aac6d0a1096e1492f"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@0601100a0fc3d9bf07d9935aac6d0a1096e1492f",
"title": "0601100a0fc3d9bf07d9935aac6d0a1096e1492f",
"url": "https://chromium.googlesource.com/chromium/src/+/0601100a0fc3d9bf07d9935aac6d0a1096e1492f"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "6e2d1be489de695222df609b638af1e9f20b0d87"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@6e2d1be489de695222df609b638af1e9f20b0d87",
"title": "6e2d1be489de695222df609b638af1e9f20b0d87",
"url": "https://chromium.googlesource.com/chromium/src/+/6e2d1be489de695222df609b638af1e9f20b0d87"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d4db4638bf522afc31d5b0bb905d99c5b83384c9"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@d4db4638bf522afc31d5b0bb905d99c5b83384c9",
"title": "d4db4638bf522afc31d5b0bb905d99c5b83384c9",
"url": "https://chromium.googlesource.com/chromium/src/+/d4db4638bf522afc31d5b0bb905d99c5b83384c9"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d4db4638bf522afc31d5b0bb905d99c5b83384c9",
"ref": "refs/branch-heads/7632"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8855347740789145248"
},
{
"key": "scheduler_job_id",
"value": "chromium-m145/win-official"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[05:08:40.794] Scheduled build:
{
"id": "8689917678820452065",
"builder": {
"project": "chromium-m145",
"bucket": "ci",
"builder": "win-official"
},
"number": 243,
"createdBy": "project:chromium-m145",
"createTime": "2026-02-14T05:08:40.232388524Z",
"updateTime": "2026-02-14T05:08:40.232388524Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d4db4638bf522afc31d5b0bb905d99c5b83384c9",
"ref": "refs/branch-heads/7632"
}
}
}
[05:08:40.794] Task URL: https://cr-buildbucket.appspot.com/build/8689917678820452065
[05:08:40.794] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:2:0) after 5m48s
[05:08:41.799] Received PubSub notification, asking Buildbucket for the build status
[05:08:41.819] Build status: SCHEDULED
[05:08:44.942] Received PubSub notification, asking Buildbucket for the build status
[05:08:45.020] Build status: STARTED
[05:14:28.925] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:2:0)
[05:14:28.956] Build status: STARTED
[05:14:28.956] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:5:0) after 1m1s
[05:15:29.972] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:5:0)
[05:15:29.987] Build status: STARTED
[05:15:29.987] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:6:0) after 5m3s
[05:20:33.035] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:6:0)
[05:20:33.054] Build status: STARTED
[05:20:33.054] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:7:0) after 1m49s
[05:22:22.070] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:7:0)
[05:22:22.093] Build status: STARTED
[05:22:22.093] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:8:0) after 1m36s
[05:23:58.317] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:8:0)
[05:23:58.379] Build status: STARTED
[05:23:58.379] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:9:0) after 8m8s
[05:32:06.481] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:9:0)
[05:32:06.499] Build status: STARTED
[05:32:06.499] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:10:0) after 8m0s
[05:40:06.738] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:10:0)
[05:40:06.831] Build status: STARTED
[05:40:06.831] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:11:0) after 7m52s
[05:47:58.907] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:11:0)
[05:47:59.075] Build status: STARTED
[05:47:59.076] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:12:0) after 6m18s
[05:54:17.136] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:12:0)
[05:54:17.150] Build status: STARTED
[05:54:17.150] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:13:0) after 8m2s
[06:02:19.166] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:13:0)
[06:02:19.184] Build status: STARTED
[06:02:19.184] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:14:0) after 6m43s
[06:09:02.244] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:14:0)
[06:09:02.258] Build status: STARTED
[06:09:02.258] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:15:0) after 6m23s
[06:15:25.536] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:15:0)
[06:15:25.556] Build status: STARTED
[06:15:25.556] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:16:0) after 3m39s
[06:19:04.580] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:16:0)
[06:19:04.593] Build status: STARTED
[06:19:04.593] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:17:0) after 7m20s
[06:26:24.611] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:17:0)
[06:26:24.629] Build status: STARTED
[06:26:24.629] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:18:0) after 7m18s
[06:33:42.644] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:18:0)
[06:33:42.665] Build status: STARTED
[06:33:42.665] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:19:0) after 7m11s
[06:40:53.687] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:19:0)
[06:40:53.701] Build status: STARTED
[06:40:53.701] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:20:0) after 8m23s
[06:49:16.770] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:20:0)
[06:49:16.791] Build status: STARTED
[06:49:16.791] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:21:0) after 7m32s
[06:56:49.062] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:21:0)
[06:56:49.201] Build status: STARTED
[06:56:49.201] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:22:0) after 6m40s
[07:03:29.219] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:22:0)
[07:03:29.237] Build status: STARTED
[07:03:29.238] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:23:0) after 9m36s
[07:13:05.507] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:23:0)
[07:13:05.535] Build status: STARTED
[07:13:05.535] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:24:0) after 2m38s
[07:15:43.551] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:24:0)
[07:15:43.566] Build status: STARTED
[07:15:43.566] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:25:0) after 6m29s
[07:22:12.633] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:25:0)
[07:22:12.655] Build status: STARTED
[07:22:12.655] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:26:0) after 5m15s
[07:27:27.670] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:26:0)
[07:27:27.685] Build status: STARTED
[07:27:27.685] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:27:0) after 5m47s
[07:33:14.737] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:27:0)
[07:33:14.751] Build status: STARTED
[07:33:14.751] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:28:0) after 2m7s
[07:35:21.744] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:28:0)
[07:35:21.762] Build status: STARTED
[07:35:21.762] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:29:0) after 1m48s
[07:37:09.780] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:29:0)
[07:37:09.793] Build status: STARTED
[07:37:09.793] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:30:0) after 4m57s
[07:42:06.883] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:30:0)
[07:42:06.898] Build status: STARTED
[07:42:06.898] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:31:0) after 5m26s
[07:47:33.007] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:31:0)
[07:47:33.027] Build status: STARTED
[07:47:33.027] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8855347740789145248:32:0) after 9m11s
[07:55:54.080] Received PubSub notification, asking Buildbucket for the build status
[07:55:54.096] Build:
{
"id": "8689917678820452065",
"builder": {
"project": "chromium-m145",
"bucket": "ci",
"builder": "win-official"
},
"number": 243,
"createdBy": "project:chromium-m145",
"createTime": "2026-02-14T05:08:40.232388524Z",
"startTime": "2026-02-14T05:08:44.765141970Z",
"endTime": "2026-02-14T07:55:53.621608963Z",
"updateTime": "2026-02-14T07:55:53.621608963Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d4db4638bf522afc31d5b0bb905d99c5b83384c9",
"ref": "refs/branch-heads/7632"
}
}
}
[07:55:54.096] Invocation finished in 2h47m15.124659431s with status SUCCEEDED