[17:31:57.463] New invocation is queued and will start shortly
[17:31:59.413] Starting the invocation (attempt 1)
[17:31:59.447] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fc0358918866416d83aa14b8435dec8ff4d51b17"
[17:31:59.447] Popped gitiles commit info from properties and tags
[17:31:59.447] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:31:59.447] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:31:59.448] Buildbucket request:
{
"requestId": "8851042918476439552",
"builder": {
"project": "chromium-m147",
"bucket": "ci",
"builder": "win-arm64-rel"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8851042918476439552",
"job": "chromium-m147/win-arm64-rel",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7727",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "3d9d84f8697d533f42974ee53ea0e87e0e9125ab"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7727@3d9d84f8697d533f42974ee53ea0e87e0e9125ab",
"title": "3d9d84f8697d533f42974ee53ea0e87e0e9125ab",
"url": "https://chromium.googlesource.com/chromium/src/+/3d9d84f8697d533f42974ee53ea0e87e0e9125ab"
},
{
"gitiles": {
"ref": "refs/branch-heads/7727",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b27b74f5c555e4ad1e924ecdccfaa8a087f8e6a6"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7727@b27b74f5c555e4ad1e924ecdccfaa8a087f8e6a6",
"title": "b27b74f5c555e4ad1e924ecdccfaa8a087f8e6a6",
"url": "https://chromium.googlesource.com/chromium/src/+/b27b74f5c555e4ad1e924ecdccfaa8a087f8e6a6"
},
{
"gitiles": {
"ref": "refs/branch-heads/7727",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c883fdc55cfa0b54f0c9310da3dcd17e38524771"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7727@c883fdc55cfa0b54f0c9310da3dcd17e38524771",
"title": "c883fdc55cfa0b54f0c9310da3dcd17e38524771",
"url": "https://chromium.googlesource.com/chromium/src/+/c883fdc55cfa0b54f0c9310da3dcd17e38524771"
},
{
"gitiles": {
"ref": "refs/branch-heads/7727",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "1ba857c0a3b915f980f623004cfed1f5fa881355"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7727@1ba857c0a3b915f980f623004cfed1f5fa881355",
"title": "1ba857c0a3b915f980f623004cfed1f5fa881355",
"url": "https://chromium.googlesource.com/chromium/src/+/1ba857c0a3b915f980f623004cfed1f5fa881355"
},
{
"gitiles": {
"ref": "refs/branch-heads/7727",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "2fb23b9dc906b0adc5693a4993059a0ec5446920"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7727@2fb23b9dc906b0adc5693a4993059a0ec5446920",
"title": "2fb23b9dc906b0adc5693a4993059a0ec5446920",
"url": "https://chromium.googlesource.com/chromium/src/+/2fb23b9dc906b0adc5693a4993059a0ec5446920"
},
{
"gitiles": {
"ref": "refs/branch-heads/7727",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "166b0462cfe044a48fc70c59170872f6c1c0ff39"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7727@166b0462cfe044a48fc70c59170872f6c1c0ff39",
"title": "166b0462cfe044a48fc70c59170872f6c1c0ff39",
"url": "https://chromium.googlesource.com/chromium/src/+/166b0462cfe044a48fc70c59170872f6c1c0ff39"
},
{
"gitiles": {
"ref": "refs/branch-heads/7727",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "da04072f8531f3192c9ea495233e34cbab3a5d13"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7727@da04072f8531f3192c9ea495233e34cbab3a5d13",
"title": "da04072f8531f3192c9ea495233e34cbab3a5d13",
"url": "https://chromium.googlesource.com/chromium/src/+/da04072f8531f3192c9ea495233e34cbab3a5d13"
},
{
"gitiles": {
"ref": "refs/branch-heads/7727",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "746911444cb6e4edb47c4819ad32753dcc038451"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7727@746911444cb6e4edb47c4819ad32753dcc038451",
"title": "746911444cb6e4edb47c4819ad32753dcc038451",
"url": "https://chromium.googlesource.com/chromium/src/+/746911444cb6e4edb47c4819ad32753dcc038451"
},
{
"gitiles": {
"ref": "refs/branch-heads/7727",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "67eaffbee2ac054a23436404dde811f5b8e384d6"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7727@67eaffbee2ac054a23436404dde811f5b8e384d6",
"title": "67eaffbee2ac054a23436404dde811f5b8e384d6",
"url": "https://chromium.googlesource.com/chromium/src/+/67eaffbee2ac054a23436404dde811f5b8e384d6"
},
{
"gitiles": {
"ref": "refs/branch-heads/7727",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "8d26d5438b2325b3553f9fd758c87ba0927d3e80"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7727@8d26d5438b2325b3553f9fd758c87ba0927d3e80",
"title": "8d26d5438b2325b3553f9fd758c87ba0927d3e80",
"url": "https://chromium.googlesource.com/chromium/src/+/8d26d5438b2325b3553f9fd758c87ba0927d3e80"
},
{
"gitiles": {
"ref": "refs/branch-heads/7727",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "92ff986c3196d944a383ffd73a384bd27aec1807"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7727@92ff986c3196d944a383ffd73a384bd27aec1807",
"title": "92ff986c3196d944a383ffd73a384bd27aec1807",
"url": "https://chromium.googlesource.com/chromium/src/+/92ff986c3196d944a383ffd73a384bd27aec1807"
},
{
"gitiles": {
"ref": "refs/branch-heads/7727",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "81b6803e71694a27e5e94d373d58ebaf9daa0c75"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7727@81b6803e71694a27e5e94d373d58ebaf9daa0c75",
"title": "81b6803e71694a27e5e94d373d58ebaf9daa0c75",
"url": "https://chromium.googlesource.com/chromium/src/+/81b6803e71694a27e5e94d373d58ebaf9daa0c75"
},
{
"gitiles": {
"ref": "refs/branch-heads/7727",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "fc0358918866416d83aa14b8435dec8ff4d51b17"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7727@fc0358918866416d83aa14b8435dec8ff4d51b17",
"title": "fc0358918866416d83aa14b8435dec8ff4d51b17",
"url": "https://chromium.googlesource.com/chromium/src/+/fc0358918866416d83aa14b8435dec8ff4d51b17"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "fc0358918866416d83aa14b8435dec8ff4d51b17",
"ref": "refs/branch-heads/7727"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8851042918476439552"
},
{
"key": "scheduler_job_id",
"value": "chromium-m147/win-arm64-rel"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[17:32:00.193] Scheduled build:
{
"id": "8685612855654040721",
"builder": {
"project": "chromium-m147",
"bucket": "ci",
"builder": "win-arm64-rel"
},
"number": 219,
"createdBy": "project:chromium-m147",
"createTime": "2026-04-02T17:31:59.522719780Z",
"updateTime": "2026-04-02T17:31:59.522719780Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "fc0358918866416d83aa14b8435dec8ff4d51b17",
"ref": "refs/branch-heads/7727"
}
}
}
[17:32:00.193] Task URL: https://cr-buildbucket.appspot.com/build/8685612855654040721
[17:32:00.193] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:2:0) after 8m15s
[17:32:01.997] Received PubSub notification, asking Buildbucket for the build status
[17:32:02.018] Build status: SCHEDULED
[17:33:18.787] Received PubSub notification, asking Buildbucket for the build status
[17:33:18.810] Build status: STARTED
[17:40:15.168] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:2:0)
[17:40:15.186] Build status: STARTED
[17:40:15.186] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:5:0) after 6m1s
[17:46:16.227] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:5:0)
[17:46:16.250] Build status: STARTED
[17:46:16.250] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:6:0) after 6m30s
[17:52:46.273] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:6:0)
[17:52:46.297] Build status: STARTED
[17:52:46.297] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:7:0) after 6m10s
[17:58:56.327] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:7:0)
[17:58:56.356] Build status: STARTED
[17:58:56.356] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:8:0) after 3m48s
[18:02:44.388] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:8:0)
[18:02:44.409] Build status: STARTED
[18:02:44.409] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:9:0) after 4m10s
[18:06:54.619] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:9:0)
[18:06:54.685] Build status: STARTED
[18:06:54.685] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:10:0) after 8m41s
[18:15:35.705] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:10:0)
[18:15:35.723] Build status: STARTED
[18:15:35.723] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:11:0) after 1m43s
[18:17:18.795] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:11:0)
[18:17:18.858] Build status: STARTED
[18:17:18.858] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:12:0) after 9m50s
[18:27:08.990] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:12:0)
[18:27:09.035] Build status: STARTED
[18:27:09.035] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:13:0) after 4m8s
[18:31:17.106] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:13:0)
[18:31:17.196] Build status: STARTED
[18:31:17.196] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:14:0) after 5m13s
[18:36:30.260] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:14:0)
[18:36:30.275] Build status: STARTED
[18:36:30.275] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:15:0) after 6m55s
[18:43:25.277] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:15:0)
[18:43:25.299] Build status: STARTED
[18:43:25.299] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:16:0) after 9m49s
[18:53:14.432] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:16:0)
[18:53:14.499] Build status: STARTED
[18:53:14.499] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:17:0) after 8m22s
[19:01:36.518] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:17:0)
[19:01:36.571] Build status: STARTED
[19:01:36.571] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:18:0) after 5m16s
[19:06:52.592] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:18:0)
[19:06:52.610] Build status: STARTED
[19:06:52.610] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:19:0) after 9m6s
[19:15:58.728] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:19:0)
[19:15:58.759] Build status: STARTED
[19:15:58.759] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:20:0) after 7m8s
[19:23:06.744] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:20:0)
[19:23:06.766] Build status: STARTED
[19:23:06.766] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:21:0) after 7m17s
[19:30:23.787] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:21:0)
[19:30:23.810] Build status: STARTED
[19:30:23.810] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:22:0) after 6m38s
[19:37:01.869] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:22:0)
[19:37:01.924] Build status: STARTED
[19:37:01.924] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:23:0) after 4m11s
[19:41:12.947] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:23:0)
[19:41:12.965] Build status: STARTED
[19:41:12.965] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:24:0) after 1m13s
[19:42:25.975] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:24:0)
[19:42:26.005] Build status: STARTED
[19:42:26.005] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:25:0) after 1m36s
[19:44:02.030] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:25:0)
[19:44:02.058] Build status: STARTED
[19:44:02.058] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:26:0) after 1m13s
[19:45:15.074] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:26:0)
[19:45:15.092] Build status: STARTED
[19:45:15.092] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:27:0) after 2m29s
[19:47:44.145] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:27:0)
[19:47:44.163] Build status: STARTED
[19:47:44.163] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:28:0) after 1m10s
[19:48:54.176] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:28:0)
[19:48:54.200] Build status: STARTED
[19:48:54.200] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:29:0) after 7m12s
[19:56:06.260] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:29:0)
[19:56:06.281] Build status: STARTED
[19:56:06.282] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:30:0) after 5m58s
[20:02:04.405] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:30:0)
[20:02:04.467] Build status: STARTED
[20:02:04.467] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:31:0) after 9m10s
[20:11:14.536] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:31:0)
[20:11:14.575] Build status: STARTED
[20:11:14.575] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:32:0) after 5m44s
[20:16:58.590] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:32:0)
[20:16:58.606] Build status: STARTED
[20:16:58.606] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:33:0) after 4m32s
[20:21:30.732] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:33:0)
[20:21:30.749] Build status: STARTED
[20:21:30.749] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:34:0) after 7m37s
[20:29:07.717] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:34:0)
[20:29:07.752] Build status: STARTED
[20:29:07.752] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851042918476439552:35:0) after 4m53s
[20:33:40.609] Received PubSub notification, asking Buildbucket for the build status
[20:33:40.628] Build:
{
"id": "8685612855654040721",
"builder": {
"project": "chromium-m147",
"bucket": "ci",
"builder": "win-arm64-rel"
},
"number": 219,
"createdBy": "project:chromium-m147",
"createTime": "2026-04-02T17:31:59.522719780Z",
"startTime": "2026-04-02T17:33:18.597624811Z",
"endTime": "2026-04-02T20:33:40.171205655Z",
"updateTime": "2026-04-02T20:33:40.171205655Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "fc0358918866416d83aa14b8435dec8ff4d51b17",
"ref": "refs/branch-heads/7727"
}
}
}
[20:33:40.628] Invocation finished in 3h1m43.180968697s with status SUCCEEDED