[17:55:50.336] New invocation is queued and will start shortly
[17:55:51.501] Starting the invocation (attempt 1)
[17:55:51.547] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/09538a38d2f8e73ab67711613d983cf1d6ccdb3c"
[17:55:51.547] Popped gitiles commit info from properties and tags
[17:55:51.547] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:55:51.547] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:55:51.547] Buildbucket request:
{
"requestId": "8849229476665268224",
"builder": {
"project": "chromium-m147",
"bucket": "ci",
"builder": "linux-chromeos-dbg"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8849229476665268224",
"job": "chromium-m147/linux-chromeos-dbg",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7727",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "8ab7b0629f3946edab8ce9b32c69f59892b5b25b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7727@8ab7b0629f3946edab8ce9b32c69f59892b5b25b",
"title": "8ab7b0629f3946edab8ce9b32c69f59892b5b25b",
"url": "https://chromium.googlesource.com/chromium/src/+/8ab7b0629f3946edab8ce9b32c69f59892b5b25b"
},
{
"gitiles": {
"ref": "refs/branch-heads/7727",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b315761e0171b96dc730a945dceafccc49c7294a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7727@b315761e0171b96dc730a945dceafccc49c7294a",
"title": "b315761e0171b96dc730a945dceafccc49c7294a",
"url": "https://chromium.googlesource.com/chromium/src/+/b315761e0171b96dc730a945dceafccc49c7294a"
},
{
"gitiles": {
"ref": "refs/branch-heads/7727",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "981815f181f254ac437619c1f60906c13a43b7f1"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7727@981815f181f254ac437619c1f60906c13a43b7f1",
"title": "981815f181f254ac437619c1f60906c13a43b7f1",
"url": "https://chromium.googlesource.com/chromium/src/+/981815f181f254ac437619c1f60906c13a43b7f1"
},
{
"gitiles": {
"ref": "refs/branch-heads/7727",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "1c9ad304823d52ec729611c1057a31eac0d92b4a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7727@1c9ad304823d52ec729611c1057a31eac0d92b4a",
"title": "1c9ad304823d52ec729611c1057a31eac0d92b4a",
"url": "https://chromium.googlesource.com/chromium/src/+/1c9ad304823d52ec729611c1057a31eac0d92b4a"
},
{
"gitiles": {
"ref": "refs/branch-heads/7727",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ceba6851ca9ba8d8ff489a04fb92eaa46094443b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7727@ceba6851ca9ba8d8ff489a04fb92eaa46094443b",
"title": "ceba6851ca9ba8d8ff489a04fb92eaa46094443b",
"url": "https://chromium.googlesource.com/chromium/src/+/ceba6851ca9ba8d8ff489a04fb92eaa46094443b"
},
{
"gitiles": {
"ref": "refs/branch-heads/7727",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "69b77bce3dd7f41694968e1923d4bc77fb15ee67"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7727@69b77bce3dd7f41694968e1923d4bc77fb15ee67",
"title": "69b77bce3dd7f41694968e1923d4bc77fb15ee67",
"url": "https://chromium.googlesource.com/chromium/src/+/69b77bce3dd7f41694968e1923d4bc77fb15ee67"
},
{
"gitiles": {
"ref": "refs/branch-heads/7727",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "3ae57ce6ea4fdbba0e69523a605269ad0a510c90"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7727@3ae57ce6ea4fdbba0e69523a605269ad0a510c90",
"title": "3ae57ce6ea4fdbba0e69523a605269ad0a510c90",
"url": "https://chromium.googlesource.com/chromium/src/+/3ae57ce6ea4fdbba0e69523a605269ad0a510c90"
},
{
"gitiles": {
"ref": "refs/branch-heads/7727",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "10cd3b64897a54b33bdbc56ab4b8b08274078350"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7727@10cd3b64897a54b33bdbc56ab4b8b08274078350",
"title": "10cd3b64897a54b33bdbc56ab4b8b08274078350",
"url": "https://chromium.googlesource.com/chromium/src/+/10cd3b64897a54b33bdbc56ab4b8b08274078350"
},
{
"gitiles": {
"ref": "refs/branch-heads/7727",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "8d3db560ad6e1cfa0bbcb3426a94212d32840cbe"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7727@8d3db560ad6e1cfa0bbcb3426a94212d32840cbe",
"title": "8d3db560ad6e1cfa0bbcb3426a94212d32840cbe",
"url": "https://chromium.googlesource.com/chromium/src/+/8d3db560ad6e1cfa0bbcb3426a94212d32840cbe"
},
{
"gitiles": {
"ref": "refs/branch-heads/7727",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "09538a38d2f8e73ab67711613d983cf1d6ccdb3c"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7727@09538a38d2f8e73ab67711613d983cf1d6ccdb3c",
"title": "09538a38d2f8e73ab67711613d983cf1d6ccdb3c",
"url": "https://chromium.googlesource.com/chromium/src/+/09538a38d2f8e73ab67711613d983cf1d6ccdb3c"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "09538a38d2f8e73ab67711613d983cf1d6ccdb3c",
"ref": "refs/branch-heads/7727"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8849229476665268224"
},
{
"key": "scheduler_job_id",
"value": "chromium-m147/linux-chromeos-dbg"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[17:55:52.026] Scheduled build:
{
"id": "8683799414665097105",
"builder": {
"project": "chromium-m147",
"bucket": "ci",
"builder": "linux-chromeos-dbg"
},
"number": 491,
"createdBy": "project:chromium-m147",
"createTime": "2026-04-22T17:55:51.618168485Z",
"updateTime": "2026-04-22T17:55:51.618168485Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "09538a38d2f8e73ab67711613d983cf1d6ccdb3c",
"ref": "refs/branch-heads/7727"
}
}
}
[17:55:52.026] Task URL: https://cr-buildbucket.appspot.com/build/8683799414665097105
[17:55:52.026] Scheduling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:2:0) after 3m23s
[17:55:52.976] Received PubSub notification, asking Buildbucket for the build status
[17:55:53.035] Build status: SCHEDULED
[17:56:47.733] Received PubSub notification, asking Buildbucket for the build status
[17:56:47.857] Build status: STARTED
[17:59:15.041] Handling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:2:0)
[17:59:15.103] Build status: STARTED
[17:59:15.103] Scheduling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:5:0) after 4m40s
[18:03:55.124] Handling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:5:0)
[18:03:55.165] Build status: STARTED
[18:03:55.165] Scheduling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:6:0) after 6m36s
[18:10:31.291] Handling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:6:0)
[18:10:31.377] Build status: STARTED
[18:10:31.377] Scheduling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:7:0) after 5m46s
[18:16:17.505] Handling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:7:0)
[18:16:17.555] Build status: STARTED
[18:16:17.555] Scheduling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:8:0) after 2m48s
[18:19:05.670] Handling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:8:0)
[18:19:05.745] Build status: STARTED
[18:19:05.745] Scheduling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:9:0) after 2m26s
[18:21:31.826] Handling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:9:0)
[18:21:31.843] Build status: STARTED
[18:21:31.843] Scheduling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:10:0) after 7m53s
[18:29:24.858] Handling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:10:0)
[18:29:24.875] Build status: STARTED
[18:29:24.875] Scheduling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:11:0) after 7m47s
[18:37:11.934] Handling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:11:0)
[18:37:11.953] Build status: STARTED
[18:37:11.953] Scheduling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:12:0) after 7m40s
[18:44:52.012] Handling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:12:0)
[18:44:52.035] Build status: STARTED
[18:44:52.035] Scheduling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:13:0) after 9m32s
[18:54:24.105] Handling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:13:0)
[18:54:24.124] Build status: STARTED
[18:54:24.125] Scheduling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:14:0) after 3m44s
[18:58:08.207] Handling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:14:0)
[18:58:08.224] Build status: STARTED
[18:58:08.224] Scheduling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:15:0) after 7m56s
[19:06:04.319] Handling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:15:0)
[19:06:04.338] Build status: STARTED
[19:06:04.338] Scheduling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:16:0) after 5m52s
[19:11:56.539] Handling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:16:0)
[19:11:56.557] Build status: STARTED
[19:11:56.557] Scheduling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:17:0) after 6m8s
[19:18:04.578] Handling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:17:0)
[19:18:04.700] Build status: STARTED
[19:18:04.700] Scheduling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:18:0) after 7m23s
[19:25:27.729] Handling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:18:0)
[19:25:27.749] Build status: STARTED
[19:25:27.749] Scheduling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:19:0) after 3m53s
[19:29:20.814] Handling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:19:0)
[19:29:20.835] Build status: STARTED
[19:29:20.835] Scheduling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:20:0) after 9m56s
[19:39:16.886] Handling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:20:0)
[19:39:16.907] Build status: STARTED
[19:39:16.907] Scheduling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:21:0) after 1m4s
[19:40:20.921] Handling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:21:0)
[19:40:20.939] Build status: STARTED
[19:40:20.939] Scheduling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:22:0) after 1m4s
[19:41:25.097] Handling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:22:0)
[19:41:25.142] Build status: STARTED
[19:41:25.142] Scheduling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:23:0) after 2m29s
[19:43:54.159] Handling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:23:0)
[19:43:54.175] Build status: STARTED
[19:43:54.175] Scheduling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:24:0) after 5m47s
[19:49:41.192] Handling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:24:0)
[19:49:41.211] Build status: STARTED
[19:49:41.211] Scheduling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:25:0) after 7m18s
[19:56:59.361] Handling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:25:0)
[19:56:59.394] Build status: STARTED
[19:56:59.394] Scheduling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:26:0) after 6m51s
[20:03:50.411] Handling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:26:0)
[20:03:50.428] Build status: STARTED
[20:03:50.428] Scheduling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:27:0) after 2m28s
[20:06:18.446] Handling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:27:0)
[20:06:18.494] Build status: STARTED
[20:06:18.494] Scheduling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:28:0) after 4m18s
[20:10:36.512] Handling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:28:0)
[20:10:36.535] Build status: STARTED
[20:10:36.535] Scheduling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:29:0) after 8m6s
[20:18:42.555] Handling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:29:0)
[20:18:42.585] Build status: STARTED
[20:18:42.585] Scheduling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:30:0) after 2m38s
[20:21:20.710] Handling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:30:0)
[20:21:20.733] Build status: STARTED
[20:21:20.733] Scheduling timer "check-buildbucket-build-status" (chromium-m147/linux-chromeos-dbg:8849229476665268224:31:0) after 7m55s
[20:28:44.876] Received PubSub notification, asking Buildbucket for the build status
[20:28:44.898] Build:
{
"id": "8683799414665097105",
"builder": {
"project": "chromium-m147",
"bucket": "ci",
"builder": "linux-chromeos-dbg"
},
"number": 491,
"createdBy": "project:chromium-m147",
"createTime": "2026-04-22T17:55:51.618168485Z",
"startTime": "2026-04-22T17:56:47.591393880Z",
"endTime": "2026-04-22T20:28:44.474920113Z",
"updateTime": "2026-04-22T20:28:44.474920113Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "09538a38d2f8e73ab67711613d983cf1d6ccdb3c",
"ref": "refs/branch-heads/7727"
}
}
}
[20:28:44.898] Invocation finished in 2h32m54.571143891s with status SUCCEEDED