[16:00:50.851] New invocation is queued and will start shortly
[16:00:51.935] Starting the invocation (attempt 1)
[16:00:51.969] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8fb8a4ac9a2a0119eb7dde5f9e8fad60f1b4a2d3"
[16:00:51.969] Popped gitiles commit info from properties and tags
[16:00:51.969] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:00:51.969] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:00:51.970] Buildbucket request:
{
"requestId": "8846156414442789616",
"builder": {
"project": "chromium-m148",
"bucket": "ci",
"builder": "win-arm64-rel"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8846156414442789616",
"job": "chromium-m148/win-arm64-rel",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "5623f22a1023d2fcf437867f3e03fdaffbc3b1d8"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@5623f22a1023d2fcf437867f3e03fdaffbc3b1d8",
"title": "5623f22a1023d2fcf437867f3e03fdaffbc3b1d8",
"url": "https://chromium.googlesource.com/chromium/src/+/5623f22a1023d2fcf437867f3e03fdaffbc3b1d8"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "5f3e6d34b9f016e3c7102590f9022d2c676d6e82"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@5f3e6d34b9f016e3c7102590f9022d2c676d6e82",
"title": "5f3e6d34b9f016e3c7102590f9022d2c676d6e82",
"url": "https://chromium.googlesource.com/chromium/src/+/5f3e6d34b9f016e3c7102590f9022d2c676d6e82"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d9b5b6da3e1e594714d82139eeb6ca925af03817"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@d9b5b6da3e1e594714d82139eeb6ca925af03817",
"title": "d9b5b6da3e1e594714d82139eeb6ca925af03817",
"url": "https://chromium.googlesource.com/chromium/src/+/d9b5b6da3e1e594714d82139eeb6ca925af03817"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "286a468396f022c7f389760b337ddfbb71450adc"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@286a468396f022c7f389760b337ddfbb71450adc",
"title": "286a468396f022c7f389760b337ddfbb71450adc",
"url": "https://chromium.googlesource.com/chromium/src/+/286a468396f022c7f389760b337ddfbb71450adc"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "3d3a89b3191db2722e1273c0dbd0bdc278d3f50e"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@3d3a89b3191db2722e1273c0dbd0bdc278d3f50e",
"title": "3d3a89b3191db2722e1273c0dbd0bdc278d3f50e",
"url": "https://chromium.googlesource.com/chromium/src/+/3d3a89b3191db2722e1273c0dbd0bdc278d3f50e"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "f20bf7edde0c7a07c0ba654b3d322bd87b5d4b08"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@f20bf7edde0c7a07c0ba654b3d322bd87b5d4b08",
"title": "f20bf7edde0c7a07c0ba654b3d322bd87b5d4b08",
"url": "https://chromium.googlesource.com/chromium/src/+/f20bf7edde0c7a07c0ba654b3d322bd87b5d4b08"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ff17681233f54b5a0b8a7c4f8cab8a6df941b4e3"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@ff17681233f54b5a0b8a7c4f8cab8a6df941b4e3",
"title": "ff17681233f54b5a0b8a7c4f8cab8a6df941b4e3",
"url": "https://chromium.googlesource.com/chromium/src/+/ff17681233f54b5a0b8a7c4f8cab8a6df941b4e3"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "901f9caae8cec6c0c59f02de96b67c5e88695bcd"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@901f9caae8cec6c0c59f02de96b67c5e88695bcd",
"title": "901f9caae8cec6c0c59f02de96b67c5e88695bcd",
"url": "https://chromium.googlesource.com/chromium/src/+/901f9caae8cec6c0c59f02de96b67c5e88695bcd"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4336bba0289bd39f53aa652f99949a3af83f27b8"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@4336bba0289bd39f53aa652f99949a3af83f27b8",
"title": "4336bba0289bd39f53aa652f99949a3af83f27b8",
"url": "https://chromium.googlesource.com/chromium/src/+/4336bba0289bd39f53aa652f99949a3af83f27b8"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "faa39db240026ffe6c93d4250e5ee4ed628ad925"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@faa39db240026ffe6c93d4250e5ee4ed628ad925",
"title": "faa39db240026ffe6c93d4250e5ee4ed628ad925",
"url": "https://chromium.googlesource.com/chromium/src/+/faa39db240026ffe6c93d4250e5ee4ed628ad925"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "52f2425c43f2ca0091b7b28f5aadb2cdffff25a8"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@52f2425c43f2ca0091b7b28f5aadb2cdffff25a8",
"title": "52f2425c43f2ca0091b7b28f5aadb2cdffff25a8",
"url": "https://chromium.googlesource.com/chromium/src/+/52f2425c43f2ca0091b7b28f5aadb2cdffff25a8"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "8fb8a4ac9a2a0119eb7dde5f9e8fad60f1b4a2d3"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@8fb8a4ac9a2a0119eb7dde5f9e8fad60f1b4a2d3",
"title": "8fb8a4ac9a2a0119eb7dde5f9e8fad60f1b4a2d3",
"url": "https://chromium.googlesource.com/chromium/src/+/8fb8a4ac9a2a0119eb7dde5f9e8fad60f1b4a2d3"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "8fb8a4ac9a2a0119eb7dde5f9e8fad60f1b4a2d3",
"ref": "refs/branch-heads/7778"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8846156414442789616"
},
{
"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"
}
}
[16:00:54.064] Scheduled build:
{
"id": "8680726352168749985",
"builder": {
"project": "chromium-m148",
"bucket": "ci",
"builder": "win-arm64-rel"
},
"number": 731,
"createdBy": "project:chromium-m148",
"createTime": "2026-05-26T16:00:52.393192579Z",
"updateTime": "2026-05-26T16:00:52.393192579Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "8fb8a4ac9a2a0119eb7dde5f9e8fad60f1b4a2d3",
"ref": "refs/branch-heads/7778"
}
}
}
[16:00:54.064] Task URL: https://cr-buildbucket.appspot.com/build/8680726352168749985
[16:00:54.064] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8846156414442789616:2:0) after 9m20s
[16:00:54.949] Received PubSub notification, asking Buildbucket for the build status
[16:00:54.987] Build status: SCHEDULED
[16:01:07.250] Received PubSub notification, asking Buildbucket for the build status
[16:01:07.357] Build status: STARTED
[16:10:14.101] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8846156414442789616:2:0)
[16:10:14.229] Build status: STARTED
[16:10:14.229] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8846156414442789616:5:0) after 8m26s
[16:18:40.281] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8846156414442789616:5:0)
[16:18:40.311] Build status: STARTED
[16:18:40.311] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8846156414442789616:6:0) after 5m52s
[16:24:32.390] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8846156414442789616:6:0)
[16:24:32.415] Build status: STARTED
[16:24:32.415] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8846156414442789616:7:0) after 5m43s
[16:30:15.408] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8846156414442789616:7:0)
[16:30:15.428] Build status: STARTED
[16:30:15.428] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8846156414442789616:8:0) after 5m35s
[16:35:50.453] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8846156414442789616:8:0)
[16:35:50.561] Build status: STARTED
[16:35:50.561] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8846156414442789616:9:0) after 4m10s
[16:40:00.576] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8846156414442789616:9:0)
[16:40:00.595] Build status: STARTED
[16:40:00.595] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8846156414442789616:10:0) after 6m11s
[16:46:11.647] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8846156414442789616:10:0)
[16:46:11.733] Build status: STARTED
[16:46:11.733] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8846156414442789616:11:0) after 6m5s
[16:52:16.747] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8846156414442789616:11:0)
[16:52:16.795] Build status: STARTED
[16:52:16.795] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8846156414442789616:12:0) after 6m27s
[16:58:43.840] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8846156414442789616:12:0)
[16:58:43.861] Build status: STARTED
[16:58:43.862] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8846156414442789616:13:0) after 7m43s
[17:06:26.908] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8846156414442789616:13:0)
[17:06:26.991] Build status: STARTED
[17:06:26.991] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8846156414442789616:14:0) after 4m17s
[17:10:44.193] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8846156414442789616:14:0)
[17:10:44.211] Build status: STARTED
[17:10:44.211] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-rel:8846156414442789616:15:0) after 9m16s
[17:13:26.566] Received PubSub notification, asking Buildbucket for the build status
[17:13:26.596] Build:
{
"id": "8680726352168749985",
"builder": {
"project": "chromium-m148",
"bucket": "ci",
"builder": "win-arm64-rel"
},
"number": 731,
"createdBy": "project:chromium-m148",
"createTime": "2026-05-26T16:00:52.393192579Z",
"startTime": "2026-05-26T16:01:06.332988137Z",
"endTime": "2026-05-26T17:13:25.401101752Z",
"updateTime": "2026-05-26T17:13:25.401101752Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "8fb8a4ac9a2a0119eb7dde5f9e8fad60f1b4a2d3",
"ref": "refs/branch-heads/7778"
}
}
}
[17:13:26.596] Invocation finished in 1h12m35.754552354s with status SUCCEEDED