[01:37:52.751] New invocation is queued and will start shortly
[01:37:54.247] Starting the invocation (attempt 1)
[01:37:54.275] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6874e6a74c208cf1ebfd7e7d26ea2063cb77001e"
[01:37:54.275] Popped gitiles commit info from properties and tags
[01:37:54.275] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:37:54.276] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:37:54.276] Buildbucket request:
{
"requestId": "8857988313351525008",
"builder": {
"project": "chromium-m144",
"bucket": "ci",
"builder": "win-arm64-rel"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8857988313351525008",
"job": "chromium-m144/win-arm64-rel",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "f63dd99be31de5caad20008e3e8625497b552018"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@f63dd99be31de5caad20008e3e8625497b552018",
"title": "f63dd99be31de5caad20008e3e8625497b552018",
"url": "https://chromium.googlesource.com/chromium/src/+/f63dd99be31de5caad20008e3e8625497b552018"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "59f6f19fd9640c1e977fbddb12a39bea39fa1554"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@59f6f19fd9640c1e977fbddb12a39bea39fa1554",
"title": "59f6f19fd9640c1e977fbddb12a39bea39fa1554",
"url": "https://chromium.googlesource.com/chromium/src/+/59f6f19fd9640c1e977fbddb12a39bea39fa1554"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "29a9f928ef453e7766329b3eecc9e48ad2b468db"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@29a9f928ef453e7766329b3eecc9e48ad2b468db",
"title": "29a9f928ef453e7766329b3eecc9e48ad2b468db",
"url": "https://chromium.googlesource.com/chromium/src/+/29a9f928ef453e7766329b3eecc9e48ad2b468db"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "20238a5169cdb563da5a16e14bec2b3512e6b077"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@20238a5169cdb563da5a16e14bec2b3512e6b077",
"title": "20238a5169cdb563da5a16e14bec2b3512e6b077",
"url": "https://chromium.googlesource.com/chromium/src/+/20238a5169cdb563da5a16e14bec2b3512e6b077"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "9f36a0edfff0f2122f967fa3fe8072d74297f84b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@9f36a0edfff0f2122f967fa3fe8072d74297f84b",
"title": "9f36a0edfff0f2122f967fa3fe8072d74297f84b",
"url": "https://chromium.googlesource.com/chromium/src/+/9f36a0edfff0f2122f967fa3fe8072d74297f84b"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "51e9c789f95a0a9f8979509c63f9897df788cca9"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@51e9c789f95a0a9f8979509c63f9897df788cca9",
"title": "51e9c789f95a0a9f8979509c63f9897df788cca9",
"url": "https://chromium.googlesource.com/chromium/src/+/51e9c789f95a0a9f8979509c63f9897df788cca9"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "7f2ea001f37d0613b13f8e52d0f00ea54dd1b4c9"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@7f2ea001f37d0613b13f8e52d0f00ea54dd1b4c9",
"title": "7f2ea001f37d0613b13f8e52d0f00ea54dd1b4c9",
"url": "https://chromium.googlesource.com/chromium/src/+/7f2ea001f37d0613b13f8e52d0f00ea54dd1b4c9"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "fb37a4ec9c814bdb11db95bad77e6aaf59804fb1"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@fb37a4ec9c814bdb11db95bad77e6aaf59804fb1",
"title": "fb37a4ec9c814bdb11db95bad77e6aaf59804fb1",
"url": "https://chromium.googlesource.com/chromium/src/+/fb37a4ec9c814bdb11db95bad77e6aaf59804fb1"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "86958677661d7eef235e3125a33f8814254e6111"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@86958677661d7eef235e3125a33f8814254e6111",
"title": "86958677661d7eef235e3125a33f8814254e6111",
"url": "https://chromium.googlesource.com/chromium/src/+/86958677661d7eef235e3125a33f8814254e6111"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "f9d4e874c5059b06514838509a2bcd9279a4759b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@f9d4e874c5059b06514838509a2bcd9279a4759b",
"title": "f9d4e874c5059b06514838509a2bcd9279a4759b",
"url": "https://chromium.googlesource.com/chromium/src/+/f9d4e874c5059b06514838509a2bcd9279a4759b"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "bddeb5d84f81f5e90ed647ed8f57c48ffa2fcfb1"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@bddeb5d84f81f5e90ed647ed8f57c48ffa2fcfb1",
"title": "bddeb5d84f81f5e90ed647ed8f57c48ffa2fcfb1",
"url": "https://chromium.googlesource.com/chromium/src/+/bddeb5d84f81f5e90ed647ed8f57c48ffa2fcfb1"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "3b6759f59f3a445467793683d276d498dfe96ba8"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@3b6759f59f3a445467793683d276d498dfe96ba8",
"title": "3b6759f59f3a445467793683d276d498dfe96ba8",
"url": "https://chromium.googlesource.com/chromium/src/+/3b6759f59f3a445467793683d276d498dfe96ba8"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "6874e6a74c208cf1ebfd7e7d26ea2063cb77001e"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@6874e6a74c208cf1ebfd7e7d26ea2063cb77001e",
"title": "6874e6a74c208cf1ebfd7e7d26ea2063cb77001e",
"url": "https://chromium.googlesource.com/chromium/src/+/6874e6a74c208cf1ebfd7e7d26ea2063cb77001e"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "6874e6a74c208cf1ebfd7e7d26ea2063cb77001e",
"ref": "refs/branch-heads/7559"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8857988313351525008"
},
{
"key": "scheduler_job_id",
"value": "chromium-m144/win-arm64-rel"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[01:37:54.869] Scheduled build:
{
"id": "8692558250924259505",
"builder": {
"project": "chromium-m144",
"bucket": "ci",
"builder": "win-arm64-rel"
},
"number": 446,
"createdBy": "project:chromium-m144",
"createTime": "2026-01-16T01:37:54.436307493Z",
"updateTime": "2026-01-16T01:37:54.436307493Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "6874e6a74c208cf1ebfd7e7d26ea2063cb77001e",
"ref": "refs/branch-heads/7559"
}
}
}
[01:37:54.869] Task URL: https://cr-buildbucket.appspot.com/build/8692558250924259505
[01:37:54.869] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:2:0) after 9m42s
[01:37:55.834] Received PubSub notification, asking Buildbucket for the build status
[01:37:55.863] Build status: SCHEDULED
[01:38:02.273] Received PubSub notification, asking Buildbucket for the build status
[01:38:02.310] Build status: STARTED
[01:47:36.871] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:2:0)
[01:47:36.892] Build status: STARTED
[01:47:36.893] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:5:0) after 3m39s
[01:51:15.921] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:5:0)
[01:51:15.941] Build status: STARTED
[01:51:15.941] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:6:0) after 7m18s
[01:58:34.075] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:6:0)
[01:58:34.112] Build status: STARTED
[01:58:34.112] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:7:0) after 1m52s
[02:00:26.238] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:7:0)
[02:00:26.267] Build status: STARTED
[02:00:26.267] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:8:0) after 3m10s
[02:03:36.284] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:8:0)
[02:03:36.306] Build status: STARTED
[02:03:36.306] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:9:0) after 1m36s
[02:05:12.322] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:9:0)
[02:05:12.389] Build status: STARTED
[02:05:12.389] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:10:0) after 9m13s
[02:14:25.525] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:10:0)
[02:14:25.558] Build status: STARTED
[02:14:25.559] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:11:0) after 5m44s
[02:20:09.764] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:11:0)
[02:20:09.789] Build status: STARTED
[02:20:09.789] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:12:0) after 6m42s
[02:26:51.955] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:12:0)
[02:26:51.976] Build status: STARTED
[02:26:51.976] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:13:0) after 8m23s
[02:35:15.036] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:13:0)
[02:35:15.055] Build status: STARTED
[02:35:15.055] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:14:0) after 4m37s
[02:39:52.119] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:14:0)
[02:39:52.135] Build status: STARTED
[02:39:52.136] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:15:0) after 2m58s
[02:42:50.193] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:15:0)
[02:42:50.294] Build status: STARTED
[02:42:50.294] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:16:0) after 4m3s
[02:46:53.315] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:16:0)
[02:46:53.337] Build status: STARTED
[02:46:53.337] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:17:0) after 9m24s
[02:56:17.353] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:17:0)
[02:56:17.377] Build status: STARTED
[02:56:17.377] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:18:0) after 6m39s
[03:02:56.440] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:18:0)
[03:02:56.466] Build status: STARTED
[03:02:56.466] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:19:0) after 7m1s
[03:09:57.535] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:19:0)
[03:09:57.550] Build status: STARTED
[03:09:57.550] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:20:0) after 8m0s
[03:17:57.681] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:20:0)
[03:17:57.702] Build status: STARTED
[03:17:57.702] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:21:0) after 5m23s
[03:23:20.729] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:21:0)
[03:23:20.808] Build status: STARTED
[03:23:20.808] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:22:0) after 8m46s
[03:32:06.937] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:22:0)
[03:32:06.960] Build status: STARTED
[03:32:06.960] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:23:0) after 4m37s
[03:36:43.988] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:23:0)
[03:36:44.010] Build status: STARTED
[03:36:44.010] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:24:0) after 7m49s
[03:44:33.346] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:24:0)
[03:44:33.368] Build status: STARTED
[03:44:33.368] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:25:0) after 6m19s
[03:50:52.415] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:25:0)
[03:50:52.818] Build status: STARTED
[03:50:52.818] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:26:0) after 7m57s
[03:58:49.796] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:26:0)
[03:58:49.824] Build status: STARTED
[03:58:49.825] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:27:0) after 6m26s
[04:05:15.862] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:27:0)
[04:05:15.882] Build status: STARTED
[04:05:15.882] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:28:0) after 4m6s
[04:09:21.948] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:28:0)
[04:09:21.970] Build status: STARTED
[04:09:21.970] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:29:0) after 5m11s
[04:14:33.227] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:29:0)
[04:14:33.246] Build status: STARTED
[04:14:33.246] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:30:0) after 2m8s
[04:16:41.261] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:30:0)
[04:16:41.313] Build status: STARTED
[04:16:41.313] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:31:0) after 2m52s
[04:19:33.363] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:31:0)
[04:19:33.399] Build status: STARTED
[04:19:33.399] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:32:0) after 3m6s
[04:22:39.416] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:32:0)
[04:22:39.432] Build status: STARTED
[04:22:39.432] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:33:0) after 8m26s
[04:31:05.505] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:33:0)
[04:31:05.523] Build status: STARTED
[04:31:05.523] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:34:0) after 4m7s
[04:35:12.637] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:34:0)
[04:35:12.695] Build status: STARTED
[04:35:12.695] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:35:0) after 6m31s
[04:41:43.713] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:35:0)
[04:41:43.804] Build status: STARTED
[04:41:43.805] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8857988313351525008:36:0) after 6m21s
[04:44:51.860] Received PubSub notification, asking Buildbucket for the build status
[04:44:51.878] Build:
{
"id": "8692558250924259505",
"builder": {
"project": "chromium-m144",
"bucket": "ci",
"builder": "win-arm64-rel"
},
"number": 446,
"createdBy": "project:chromium-m144",
"createTime": "2026-01-16T01:37:54.436307493Z",
"startTime": "2026-01-16T01:38:02.056956853Z",
"endTime": "2026-01-16T04:44:21.309270721Z",
"updateTime": "2026-01-16T04:44:21.309270721Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "6874e6a74c208cf1ebfd7e7d26ea2063cb77001e",
"ref": "refs/branch-heads/7559"
}
}
}
[04:44:51.878] Invocation finished in 3h6m59.140977317s with status SUCCEEDED