[21:43:03.186] New invocation is queued and will start shortly
[21:43:04.296] Starting the invocation (attempt 1)
[21:43:04.323] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b40fd189944c8c62e55b2a73368d405cd7aa9ec4"
[21:43:04.323] Popped gitiles commit info from properties and tags
[21:43:04.323] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:43:04.323] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:43:04.323] Buildbucket request:
{
"requestId": "8835444442687471792",
"builder": {
"project": "chromium-m155",
"bucket": "ci",
"builder": "chromeos-arm64-generic-rel"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8835444442687471792",
"job": "chromium-m155/chromeos-arm64-generic-rel",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/8059",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ca07c65ec4b1719d1d851d263caca9c3210353c4"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8059@ca07c65ec4b1719d1d851d263caca9c3210353c4",
"title": "ca07c65ec4b1719d1d851d263caca9c3210353c4",
"url": "https://chromium.googlesource.com/chromium/src/+/ca07c65ec4b1719d1d851d263caca9c3210353c4"
},
{
"gitiles": {
"ref": "refs/branch-heads/8059",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "28c0d434242bc820d697eea856482c5a64118ce8"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8059@28c0d434242bc820d697eea856482c5a64118ce8",
"title": "28c0d434242bc820d697eea856482c5a64118ce8",
"url": "https://chromium.googlesource.com/chromium/src/+/28c0d434242bc820d697eea856482c5a64118ce8"
},
{
"gitiles": {
"ref": "refs/branch-heads/8059",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "219399e46f2bac84a76693f6701ad41bfdd487ff"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8059@219399e46f2bac84a76693f6701ad41bfdd487ff",
"title": "219399e46f2bac84a76693f6701ad41bfdd487ff",
"url": "https://chromium.googlesource.com/chromium/src/+/219399e46f2bac84a76693f6701ad41bfdd487ff"
},
{
"gitiles": {
"ref": "refs/branch-heads/8059",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a2aed0c94d764b25c5d3b0399e26ac51b0e4e408"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8059@a2aed0c94d764b25c5d3b0399e26ac51b0e4e408",
"title": "a2aed0c94d764b25c5d3b0399e26ac51b0e4e408",
"url": "https://chromium.googlesource.com/chromium/src/+/a2aed0c94d764b25c5d3b0399e26ac51b0e4e408"
},
{
"gitiles": {
"ref": "refs/branch-heads/8059",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "6961bf0dec26c140dae6410ac449e3c1780f59c0"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8059@6961bf0dec26c140dae6410ac449e3c1780f59c0",
"title": "6961bf0dec26c140dae6410ac449e3c1780f59c0",
"url": "https://chromium.googlesource.com/chromium/src/+/6961bf0dec26c140dae6410ac449e3c1780f59c0"
},
{
"gitiles": {
"ref": "refs/branch-heads/8059",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0b1e6e8dbb15a542bef21c60fbb9be4815aa0692"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8059@0b1e6e8dbb15a542bef21c60fbb9be4815aa0692",
"title": "0b1e6e8dbb15a542bef21c60fbb9be4815aa0692",
"url": "https://chromium.googlesource.com/chromium/src/+/0b1e6e8dbb15a542bef21c60fbb9be4815aa0692"
},
{
"gitiles": {
"ref": "refs/branch-heads/8059",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "cb777dcb5e685a0065862a1937a7d5e2e4dabdc5"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8059@cb777dcb5e685a0065862a1937a7d5e2e4dabdc5",
"title": "cb777dcb5e685a0065862a1937a7d5e2e4dabdc5",
"url": "https://chromium.googlesource.com/chromium/src/+/cb777dcb5e685a0065862a1937a7d5e2e4dabdc5"
},
{
"gitiles": {
"ref": "refs/branch-heads/8059",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "74626166dbf1f180eda7d76d895ba04cce23d861"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8059@74626166dbf1f180eda7d76d895ba04cce23d861",
"title": "74626166dbf1f180eda7d76d895ba04cce23d861",
"url": "https://chromium.googlesource.com/chromium/src/+/74626166dbf1f180eda7d76d895ba04cce23d861"
},
{
"gitiles": {
"ref": "refs/branch-heads/8059",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "44d75139893fc1172bc597eef1d831fcdd5f4e06"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8059@44d75139893fc1172bc597eef1d831fcdd5f4e06",
"title": "44d75139893fc1172bc597eef1d831fcdd5f4e06",
"url": "https://chromium.googlesource.com/chromium/src/+/44d75139893fc1172bc597eef1d831fcdd5f4e06"
},
{
"gitiles": {
"ref": "refs/branch-heads/8059",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "aa52bbd62a98c563f562def93373d2265533a7a7"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8059@aa52bbd62a98c563f562def93373d2265533a7a7",
"title": "aa52bbd62a98c563f562def93373d2265533a7a7",
"url": "https://chromium.googlesource.com/chromium/src/+/aa52bbd62a98c563f562def93373d2265533a7a7"
},
{
"gitiles": {
"ref": "refs/branch-heads/8059",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "653d9309490ed1f389d2032613befcf3398472c5"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8059@653d9309490ed1f389d2032613befcf3398472c5",
"title": "653d9309490ed1f389d2032613befcf3398472c5",
"url": "https://chromium.googlesource.com/chromium/src/+/653d9309490ed1f389d2032613befcf3398472c5"
},
{
"gitiles": {
"ref": "refs/branch-heads/8059",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b40fd189944c8c62e55b2a73368d405cd7aa9ec4"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8059@b40fd189944c8c62e55b2a73368d405cd7aa9ec4",
"title": "b40fd189944c8c62e55b2a73368d405cd7aa9ec4",
"url": "https://chromium.googlesource.com/chromium/src/+/b40fd189944c8c62e55b2a73368d405cd7aa9ec4"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b40fd189944c8c62e55b2a73368d405cd7aa9ec4",
"ref": "refs/branch-heads/8059"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8835444442687471792"
},
{
"key": "scheduler_job_id",
"value": "chromium-m155/chromeos-arm64-generic-rel"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[21:43:05.357] Scheduled build:
{
"id": "8670014380699909873",
"builder": {
"project": "chromium-m155",
"bucket": "ci",
"builder": "chromeos-arm64-generic-rel"
},
"number": 72,
"createdBy": "project:chromium-m155",
"createTime": "2026-09-21T21:43:04.461190133Z",
"updateTime": "2026-09-21T21:43:04.461190133Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b40fd189944c8c62e55b2a73368d405cd7aa9ec4",
"ref": "refs/branch-heads/8059"
}
}
}
[21:43:05.357] Task URL: https://cr-buildbucket.appspot.com/build/8670014380699909873
[21:43:05.357] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:2:0) after 2m10s
[21:43:06.184] Received PubSub notification, asking Buildbucket for the build status
[21:43:06.235] Build status: SCHEDULED
[21:45:15.323] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:2:0)
[21:45:15.410] Build status: SCHEDULED
[21:45:15.410] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:4:0) after 2m29s
[21:47:44.483] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:4:0)
[21:47:44.542] Build status: SCHEDULED
[21:47:44.542] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:5:0) after 8m2s
[21:55:46.664] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:5:0)
[21:55:46.686] Build status: SCHEDULED
[21:55:46.686] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:6:0) after 9m30s
[22:05:16.681] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:6:0)
[22:05:16.702] Build status: SCHEDULED
[22:05:16.702] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:7:0) after 9m18s
[22:14:34.788] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:7:0)
[22:14:34.805] Build status: SCHEDULED
[22:14:34.805] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:8:0) after 6m38s
[22:21:12.821] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:8:0)
[22:21:12.867] Build status: SCHEDULED
[22:21:12.867] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:9:0) after 2m47s
[22:23:59.958] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:9:0)
[22:24:00.011] Build status: SCHEDULED
[22:24:00.011] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:10:0) after 9m57s
[22:33:57.029] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:10:0)
[22:33:57.050] Build status: SCHEDULED
[22:33:57.050] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:11:0) after 8m30s
[22:37:57.444] Received PubSub notification, asking Buildbucket for the build status
[22:37:57.525] Build status: STARTED
[22:42:27.109] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:11:0)
[22:42:27.160] Build status: STARTED
[22:42:27.160] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:13:0) after 9m28s
[22:51:55.183] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:13:0)
[22:51:55.202] Build status: STARTED
[22:51:55.202] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:14:0) after 8m40s
[23:00:35.319] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:14:0)
[23:00:35.399] Build status: STARTED
[23:00:35.399] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:15:0) after 1m45s
[23:02:20.416] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:15:0)
[23:02:20.457] Build status: STARTED
[23:02:20.457] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:16:0) after 2m59s
[23:05:19.515] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:16:0)
[23:05:19.591] Build status: STARTED
[23:05:19.591] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:17:0) after 1m52s
[23:07:11.569] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:17:0)
[23:07:11.591] Build status: STARTED
[23:07:11.591] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:18:0) after 4m59s
[23:12:10.760] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:18:0)
[23:12:10.782] Build status: STARTED
[23:12:10.782] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:19:0) after 2m47s
[23:14:57.800] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:19:0)
[23:14:57.834] Build status: STARTED
[23:14:57.834] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:20:0) after 6m1s
[23:20:58.841] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:20:0)
[23:20:58.863] Build status: STARTED
[23:20:58.863] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:21:0) after 3m36s
[23:24:34.906] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:21:0)
[23:24:34.937] Build status: STARTED
[23:24:34.937] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:22:0) after 7m59s
[23:32:33.955] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:22:0)
[23:32:33.974] Build status: STARTED
[23:32:33.974] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:23:0) after 7m12s
[23:39:46.085] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:23:0)
[23:39:46.104] Build status: STARTED
[23:39:46.104] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:24:0) after 4m6s
[23:43:52.201] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:24:0)
[23:43:52.220] Build status: STARTED
[23:43:52.220] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:25:0) after 4m58s
[23:48:50.244] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:25:0)
[23:48:50.264] Build status: STARTED
[23:48:50.264] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:26:0) after 9m26s
[23:58:16.308] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:26:0)
[23:58:16.329] Build status: STARTED
[23:58:16.329] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:27:0) after 7m0s
[00:05:16.382] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:27:0)
[00:05:16.427] Build status: STARTED
[00:05:16.427] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:28:0) after 2m59s
[00:08:15.517] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:28:0)
[00:08:15.538] Build status: STARTED
[00:08:15.538] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:29:0) after 4m43s
[00:12:58.687] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:29:0)
[00:12:58.734] Build status: STARTED
[00:12:58.734] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:30:0) after 7m58s
[00:20:56.751] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:30:0)
[00:20:56.769] Build status: STARTED
[00:20:56.769] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:31:0) after 3m43s
[00:24:39.812] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:31:0)
[00:24:39.840] Build status: STARTED
[00:24:39.840] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:32:0) after 5m15s
[00:29:54.855] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:32:0)
[00:29:54.875] Build status: STARTED
[00:29:54.875] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:33:0) after 2m52s
[00:32:47.037] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:33:0)
[00:32:47.058] Build status: STARTED
[00:32:47.058] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:34:0) after 6m44s
[00:39:31.299] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:34:0)
[00:39:31.318] Build status: STARTED
[00:39:31.318] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:35:0) after 7m43s
[00:47:14.345] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:35:0)
[00:47:14.417] Build status: STARTED
[00:47:14.417] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:36:0) after 3m58s
[00:51:12.461] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:36:0)
[00:51:12.480] Build status: STARTED
[00:51:12.480] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:37:0) after 3m38s
[00:54:50.575] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:37:0)
[00:54:50.600] Build status: STARTED
[00:54:50.600] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835444442687471792:38:0) after 8m48s
[00:59:51.391] Received PubSub notification, asking Buildbucket for the build status
[00:59:51.434] Build:
{
"id": "8670014380699909873",
"builder": {
"project": "chromium-m155",
"bucket": "ci",
"builder": "chromeos-arm64-generic-rel"
},
"number": 72,
"createdBy": "project:chromium-m155",
"createTime": "2026-09-21T21:43:04.461190133Z",
"startTime": "2026-09-21T22:37:57.233299712Z",
"endTime": "2026-09-22T00:59:27.008913187Z",
"updateTime": "2026-09-22T00:59:27.008913187Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b40fd189944c8c62e55b2a73368d405cd7aa9ec4",
"ref": "refs/branch-heads/8059"
}
}
}
[00:59:51.434] Invocation finished in 3h16m48.251759117s with status SUCCEEDED