[15:17:12.091] New invocation is queued and will start shortly
[15:17:14.459] Starting the invocation (attempt 1)
[15:17:14.483] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ece906867d334f8fa6203efbc5c3d4e0f01e66fb"
[15:17:14.483] Popped gitiles commit info from properties and tags
[15:17:14.483] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:17:14.483] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:17:14.484] Buildbucket request:
{
"requestId": "8850054829964244848",
"builder": {
"project": "chromium-m148",
"bucket": "ci",
"builder": "win-arm64-rel"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8850054829964244848",
"job": "chromium-m148/win-arm64-rel",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "717f0440eaac74c4ba32d0ad683c13e23249a3fb"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@717f0440eaac74c4ba32d0ad683c13e23249a3fb",
"title": "717f0440eaac74c4ba32d0ad683c13e23249a3fb",
"url": "https://chromium.googlesource.com/chromium/src/+/717f0440eaac74c4ba32d0ad683c13e23249a3fb"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "305ae407ef9e2d2fece844de79dd2ec838e68647"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@305ae407ef9e2d2fece844de79dd2ec838e68647",
"title": "305ae407ef9e2d2fece844de79dd2ec838e68647",
"url": "https://chromium.googlesource.com/chromium/src/+/305ae407ef9e2d2fece844de79dd2ec838e68647"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4aaf8716ef4377822f7ab353282d9ac3d9310a2a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@4aaf8716ef4377822f7ab353282d9ac3d9310a2a",
"title": "4aaf8716ef4377822f7ab353282d9ac3d9310a2a",
"url": "https://chromium.googlesource.com/chromium/src/+/4aaf8716ef4377822f7ab353282d9ac3d9310a2a"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e00c40f3b11e273b369677a520d7af7e45bc5c06"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@e00c40f3b11e273b369677a520d7af7e45bc5c06",
"title": "e00c40f3b11e273b369677a520d7af7e45bc5c06",
"url": "https://chromium.googlesource.com/chromium/src/+/e00c40f3b11e273b369677a520d7af7e45bc5c06"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "1fa25c4afef291bc7e318ac3cfcc72d39a440312"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@1fa25c4afef291bc7e318ac3cfcc72d39a440312",
"title": "1fa25c4afef291bc7e318ac3cfcc72d39a440312",
"url": "https://chromium.googlesource.com/chromium/src/+/1fa25c4afef291bc7e318ac3cfcc72d39a440312"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4c6d6b014ef09b510c5bf8bd21b81517a5938225"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@4c6d6b014ef09b510c5bf8bd21b81517a5938225",
"title": "4c6d6b014ef09b510c5bf8bd21b81517a5938225",
"url": "https://chromium.googlesource.com/chromium/src/+/4c6d6b014ef09b510c5bf8bd21b81517a5938225"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "983cb2cd3f78c3a36c8a29ff3ef7864259c5ec3d"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@983cb2cd3f78c3a36c8a29ff3ef7864259c5ec3d",
"title": "983cb2cd3f78c3a36c8a29ff3ef7864259c5ec3d",
"url": "https://chromium.googlesource.com/chromium/src/+/983cb2cd3f78c3a36c8a29ff3ef7864259c5ec3d"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "cb8826a5a960338c47f540a94da774b97e047b1a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@cb8826a5a960338c47f540a94da774b97e047b1a",
"title": "cb8826a5a960338c47f540a94da774b97e047b1a",
"url": "https://chromium.googlesource.com/chromium/src/+/cb8826a5a960338c47f540a94da774b97e047b1a"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "bda94471764cb7f9832c6ab298af7d9b48bee97a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@bda94471764cb7f9832c6ab298af7d9b48bee97a",
"title": "bda94471764cb7f9832c6ab298af7d9b48bee97a",
"url": "https://chromium.googlesource.com/chromium/src/+/bda94471764cb7f9832c6ab298af7d9b48bee97a"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "f06f526a837da73943696cf4b914d484f1fbc5dd"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@f06f526a837da73943696cf4b914d484f1fbc5dd",
"title": "f06f526a837da73943696cf4b914d484f1fbc5dd",
"url": "https://chromium.googlesource.com/chromium/src/+/f06f526a837da73943696cf4b914d484f1fbc5dd"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "15348038e93d282cc2426458c57e2340815c20d7"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@15348038e93d282cc2426458c57e2340815c20d7",
"title": "15348038e93d282cc2426458c57e2340815c20d7",
"url": "https://chromium.googlesource.com/chromium/src/+/15348038e93d282cc2426458c57e2340815c20d7"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ece906867d334f8fa6203efbc5c3d4e0f01e66fb"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@ece906867d334f8fa6203efbc5c3d4e0f01e66fb",
"title": "ece906867d334f8fa6203efbc5c3d4e0f01e66fb",
"url": "https://chromium.googlesource.com/chromium/src/+/ece906867d334f8fa6203efbc5c3d4e0f01e66fb"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "ece906867d334f8fa6203efbc5c3d4e0f01e66fb",
"ref": "refs/branch-heads/7778"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8850054829964244848"
},
{
"key": "scheduler_job_id",
"value": "chromium-m148/win-arm64-rel"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[15:17:15.145] Scheduled build:
{
"id": "8684624766740607521",
"builder": {
"project": "chromium-m148",
"bucket": "ci",
"builder": "win-arm64-rel"
},
"number": 53,
"createdBy": "project:chromium-m148",
"createTime": "2026-04-13T15:17:14.541984513Z",
"updateTime": "2026-04-13T15:17:14.541984513Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "ece906867d334f8fa6203efbc5c3d4e0f01e66fb",
"ref": "refs/branch-heads/7778"
}
}
}
[15:17:15.145] Task URL: https://cr-buildbucket.appspot.com/build/8684624766740607521
[15:17:15.145] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:2:0) after 2m3s
[15:17:16.303] Received PubSub notification, asking Buildbucket for the build status
[15:17:16.373] Build status: SCHEDULED
[15:17:29.495] Received PubSub notification, asking Buildbucket for the build status
[15:17:29.520] Build status: STARTED
[15:19:18.251] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:2:0)
[15:19:18.346] Build status: STARTED
[15:19:18.346] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:5:0) after 8m49s
[15:28:07.456] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:5:0)
[15:28:07.530] Build status: STARTED
[15:28:07.530] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:6:0) after 1m32s
[15:29:39.546] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:6:0)
[15:29:39.628] Build status: STARTED
[15:29:39.628] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:7:0) after 6m52s
[15:36:31.643] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:7:0)
[15:36:31.660] Build status: STARTED
[15:36:31.660] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:8:0) after 1m55s
[15:38:26.710] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:8:0)
[15:38:26.731] Build status: STARTED
[15:38:26.731] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:9:0) after 9m46s
[15:48:12.846] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:9:0)
[15:48:12.894] Build status: STARTED
[15:48:12.894] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:10:0) after 3m52s
[15:52:04.905] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:10:0)
[15:52:04.930] Build status: STARTED
[15:52:04.930] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:11:0) after 7m5s
[15:59:09.942] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:11:0)
[15:59:09.970] Build status: STARTED
[15:59:09.970] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:12:0) after 3m22s
[16:02:31.985] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:12:0)
[16:02:32.005] Build status: STARTED
[16:02:32.005] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:13:0) after 2m13s
[16:04:45.019] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:13:0)
[16:04:45.036] Build status: STARTED
[16:04:45.036] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:14:0) after 8m48s
[16:13:33.058] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:14:0)
[16:13:33.074] Build status: STARTED
[16:13:33.075] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:15:0) after 2m56s
[16:16:29.123] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:15:0)
[16:16:29.146] Build status: STARTED
[16:16:29.146] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:16:0) after 7m55s
[16:24:24.161] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:16:0)
[16:24:24.244] Build status: STARTED
[16:24:24.244] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:17:0) after 6m5s
[16:30:29.352] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:17:0)
[16:30:29.374] Build status: STARTED
[16:30:29.374] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:18:0) after 5m7s
[16:35:36.571] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:18:0)
[16:35:36.591] Build status: STARTED
[16:35:36.591] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:19:0) after 6m5s
[16:41:41.622] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:19:0)
[16:41:41.638] Build status: STARTED
[16:41:41.638] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:20:0) after 2m47s
[16:44:28.693] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:20:0)
[16:44:28.719] Build status: STARTED
[16:44:28.719] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:21:0) after 6m27s
[16:50:55.690] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:21:0)
[16:50:55.706] Build status: STARTED
[16:50:55.706] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:22:0) after 1m19s
[16:52:14.730] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:22:0)
[16:52:14.760] Build status: STARTED
[16:52:14.760] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:23:0) after 7m35s
[16:59:49.775] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:23:0)
[16:59:49.826] Build status: STARTED
[16:59:49.826] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:24:0) after 3m16s
[17:03:06.032] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:24:0)
[17:03:06.166] Build status: STARTED
[17:03:06.166] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:25:0) after 4m59s
[17:08:05.191] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:25:0)
[17:08:05.208] Build status: STARTED
[17:08:05.208] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:26:0) after 8m6s
[17:16:11.284] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:26:0)
[17:16:11.313] Build status: STARTED
[17:16:11.313] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:27:0) after 2m39s
[17:18:50.371] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:27:0)
[17:18:50.420] Build status: STARTED
[17:18:50.420] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:28:0) after 9m4s
[17:27:54.435] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:28:0)
[17:27:54.454] Build status: STARTED
[17:27:54.454] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:29:0) after 2m34s
[17:30:28.489] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:29:0)
[17:30:28.532] Build status: STARTED
[17:30:28.532] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8850054829964244848:30:0) after 7m48s
[17:34:57.933] Received PubSub notification, asking Buildbucket for the build status
[17:34:57.955] Build:
{
"id": "8684624766740607521",
"builder": {
"project": "chromium-m148",
"bucket": "ci",
"builder": "win-arm64-rel"
},
"number": 53,
"createdBy": "project:chromium-m148",
"createTime": "2026-04-13T15:17:14.541984513Z",
"startTime": "2026-04-13T15:17:24.707621567Z",
"endTime": "2026-04-13T17:34:56.497012091Z",
"updateTime": "2026-04-13T17:34:56.497012091Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "ece906867d334f8fa6203efbc5c3d4e0f01e66fb",
"ref": "refs/branch-heads/7778"
}
}
}
[17:34:57.955] Invocation finished in 2h17m45.871254858s with status SUCCEEDED