[15:53:42.779] New invocation is queued and will start shortly
[15:53:44.116] Starting the invocation (attempt 1)
[15:53:44.138] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a0436424ed50748d25a82f230d39502a1ebffed1"
[15:53:44.138] Popped gitiles commit info from properties and tags
[15:53:44.138] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:53:44.139] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:53:44.139] Buildbucket request:
{
"requestId": "8833292094076768896",
"builder": {
"project": "chromium-m157",
"bucket": "ci",
"builder": "linux-official"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8833292094076768896",
"job": "chromium-m157/linux-official",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/8103",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d046baf0d26019393a4c61355e797be610840ffa"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8103@d046baf0d26019393a4c61355e797be610840ffa",
"title": "d046baf0d26019393a4c61355e797be610840ffa",
"url": "https://chromium.googlesource.com/chromium/src/+/d046baf0d26019393a4c61355e797be610840ffa"
},
{
"gitiles": {
"ref": "refs/branch-heads/8103",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "3b4d90a4be198d59d8447413de96181b6dec416e"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8103@3b4d90a4be198d59d8447413de96181b6dec416e",
"title": "3b4d90a4be198d59d8447413de96181b6dec416e",
"url": "https://chromium.googlesource.com/chromium/src/+/3b4d90a4be198d59d8447413de96181b6dec416e"
},
{
"gitiles": {
"ref": "refs/branch-heads/8103",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "3a59e7f32e2664aefcde2789fd58e0ea4ad991d1"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8103@3a59e7f32e2664aefcde2789fd58e0ea4ad991d1",
"title": "3a59e7f32e2664aefcde2789fd58e0ea4ad991d1",
"url": "https://chromium.googlesource.com/chromium/src/+/3a59e7f32e2664aefcde2789fd58e0ea4ad991d1"
},
{
"gitiles": {
"ref": "refs/branch-heads/8103",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "849b46b4b506bfb7136d73f25d30544ac62caffa"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8103@849b46b4b506bfb7136d73f25d30544ac62caffa",
"title": "849b46b4b506bfb7136d73f25d30544ac62caffa",
"url": "https://chromium.googlesource.com/chromium/src/+/849b46b4b506bfb7136d73f25d30544ac62caffa"
},
{
"gitiles": {
"ref": "refs/branch-heads/8103",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c452ff76397bc191c6f183d690cb6221f7e2a305"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8103@c452ff76397bc191c6f183d690cb6221f7e2a305",
"title": "c452ff76397bc191c6f183d690cb6221f7e2a305",
"url": "https://chromium.googlesource.com/chromium/src/+/c452ff76397bc191c6f183d690cb6221f7e2a305"
},
{
"gitiles": {
"ref": "refs/branch-heads/8103",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "bc5e73e9dfe171f74161a88347262a23db9c3356"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8103@bc5e73e9dfe171f74161a88347262a23db9c3356",
"title": "bc5e73e9dfe171f74161a88347262a23db9c3356",
"url": "https://chromium.googlesource.com/chromium/src/+/bc5e73e9dfe171f74161a88347262a23db9c3356"
},
{
"gitiles": {
"ref": "refs/branch-heads/8103",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a0436424ed50748d25a82f230d39502a1ebffed1"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8103@a0436424ed50748d25a82f230d39502a1ebffed1",
"title": "a0436424ed50748d25a82f230d39502a1ebffed1",
"url": "https://chromium.googlesource.com/chromium/src/+/a0436424ed50748d25a82f230d39502a1ebffed1"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "a0436424ed50748d25a82f230d39502a1ebffed1",
"ref": "refs/branch-heads/8103"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8833292094076768896"
},
{
"key": "scheduler_job_id",
"value": "chromium-m157/linux-official"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[15:53:44.664] Scheduled build:
{
"id": "8667862031925309937",
"builder": {
"project": "chromium-m157",
"bucket": "ci",
"builder": "linux-official"
},
"number": 25,
"createdBy": "project:chromium-m157",
"createTime": "2026-10-15T15:53:44.207221534Z",
"updateTime": "2026-10-15T15:53:44.207221534Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "a0436424ed50748d25a82f230d39502a1ebffed1",
"ref": "refs/branch-heads/8103"
}
}
}
[15:53:44.664] Task URL: https://cr-buildbucket.appspot.com/build/8667862031925309937
[15:53:44.664] Scheduling timer "check-buildbucket-build-status" (chromium-m157/linux-official:8833292094076768896:2:0) after 6m57s
[15:53:45.626] Received PubSub notification, asking Buildbucket for the build status
[15:53:45.645] Build status: SCHEDULED
[16:00:41.678] Handling timer "check-buildbucket-build-status" (chromium-m157/linux-official:8833292094076768896:2:0)
[16:00:41.701] Build status: SCHEDULED
[16:00:41.701] Scheduling timer "check-buildbucket-build-status" (chromium-m157/linux-official:8833292094076768896:4:0) after 6m5s
[16:06:46.746] Handling timer "check-buildbucket-build-status" (chromium-m157/linux-official:8833292094076768896:4:0)
[16:06:46.773] Build status: SCHEDULED
[16:06:46.773] Scheduling timer "check-buildbucket-build-status" (chromium-m157/linux-official:8833292094076768896:5:0) after 9m11s
[16:15:57.891] Handling timer "check-buildbucket-build-status" (chromium-m157/linux-official:8833292094076768896:5:0)
[16:15:57.921] Build status: SCHEDULED
[16:15:57.921] Scheduling timer "check-buildbucket-build-status" (chromium-m157/linux-official:8833292094076768896:6:0) after 6m7s
[16:16:51.750] Received PubSub notification, asking Buildbucket for the build status
[16:16:51.770] Build status: STARTED
[16:22:04.900] Handling timer "check-buildbucket-build-status" (chromium-m157/linux-official:8833292094076768896:6:0)
[16:22:04.924] Build status: STARTED
[16:22:04.924] Scheduling timer "check-buildbucket-build-status" (chromium-m157/linux-official:8833292094076768896:8:0) after 6m10s
[16:28:15.082] Handling timer "check-buildbucket-build-status" (chromium-m157/linux-official:8833292094076768896:8:0)
[16:28:15.108] Build status: STARTED
[16:28:15.108] Scheduling timer "check-buildbucket-build-status" (chromium-m157/linux-official:8833292094076768896:9:0) after 7m46s
[16:36:01.126] Handling timer "check-buildbucket-build-status" (chromium-m157/linux-official:8833292094076768896:9:0)
[16:36:01.147] Build status: STARTED
[16:36:01.147] Scheduling timer "check-buildbucket-build-status" (chromium-m157/linux-official:8833292094076768896:10:0) after 3m13s
[16:39:14.347] Handling timer "check-buildbucket-build-status" (chromium-m157/linux-official:8833292094076768896:10:0)
[16:39:14.368] Build status: STARTED
[16:39:14.368] Scheduling timer "check-buildbucket-build-status" (chromium-m157/linux-official:8833292094076768896:11:0) after 2m18s
[16:41:32.537] Handling timer "check-buildbucket-build-status" (chromium-m157/linux-official:8833292094076768896:11:0)
[16:41:32.559] Build status: STARTED
[16:41:32.559] Scheduling timer "check-buildbucket-build-status" (chromium-m157/linux-official:8833292094076768896:12:0) after 5m9s
[16:46:41.625] Handling timer "check-buildbucket-build-status" (chromium-m157/linux-official:8833292094076768896:12:0)
[16:46:41.644] Build status: STARTED
[16:46:41.644] Scheduling timer "check-buildbucket-build-status" (chromium-m157/linux-official:8833292094076768896:13:0) after 3m21s
[16:50:02.744] Handling timer "check-buildbucket-build-status" (chromium-m157/linux-official:8833292094076768896:13:0)
[16:50:02.835] Build status: STARTED
[16:50:02.835] Scheduling timer "check-buildbucket-build-status" (chromium-m157/linux-official:8833292094076768896:14:0) after 7m44s
[16:57:46.900] Handling timer "check-buildbucket-build-status" (chromium-m157/linux-official:8833292094076768896:14:0)
[16:57:46.996] Build status: STARTED
[16:57:46.996] Scheduling timer "check-buildbucket-build-status" (chromium-m157/linux-official:8833292094076768896:15:0) after 7m5s
[17:04:52.227] Handling timer "check-buildbucket-build-status" (chromium-m157/linux-official:8833292094076768896:15:0)
[17:04:52.250] Build status: STARTED
[17:04:52.250] Scheduling timer "check-buildbucket-build-status" (chromium-m157/linux-official:8833292094076768896:16:0) after 4m43s
[17:09:35.271] Handling timer "check-buildbucket-build-status" (chromium-m157/linux-official:8833292094076768896:16:0)
[17:09:35.289] Build status: STARTED
[17:09:35.289] Scheduling timer "check-buildbucket-build-status" (chromium-m157/linux-official:8833292094076768896:17:0) after 4m1s
[17:13:36.356] Handling timer "check-buildbucket-build-status" (chromium-m157/linux-official:8833292094076768896:17:0)
[17:13:36.382] Build status: STARTED
[17:13:36.382] Scheduling timer "check-buildbucket-build-status" (chromium-m157/linux-official:8833292094076768896:18:0) after 2m46s
[17:16:22.575] Handling timer "check-buildbucket-build-status" (chromium-m157/linux-official:8833292094076768896:18:0)
[17:16:22.598] Build status: STARTED
[17:16:22.598] Scheduling timer "check-buildbucket-build-status" (chromium-m157/linux-official:8833292094076768896:19:0) after 4m38s
[17:21:00.619] Handling timer "check-buildbucket-build-status" (chromium-m157/linux-official:8833292094076768896:19:0)
[17:21:00.653] Build status: STARTED
[17:21:00.653] Scheduling timer "check-buildbucket-build-status" (chromium-m157/linux-official:8833292094076768896:20:0) after 5m12s
[17:26:12.676] Handling timer "check-buildbucket-build-status" (chromium-m157/linux-official:8833292094076768896:20:0)
[17:26:12.735] Build status: STARTED
[17:26:12.735] Scheduling timer "check-buildbucket-build-status" (chromium-m157/linux-official:8833292094076768896:21:0) after 1m23s
[17:27:35.845] Handling timer "check-buildbucket-build-status" (chromium-m157/linux-official:8833292094076768896:21:0)
[17:27:35.874] Build status: STARTED
[17:27:35.875] Scheduling timer "check-buildbucket-build-status" (chromium-m157/linux-official:8833292094076768896:22:0) after 9m57s
[17:37:32.937] Handling timer "check-buildbucket-build-status" (chromium-m157/linux-official:8833292094076768896:22:0)
[17:37:32.955] Build status: STARTED
[17:37:32.955] Scheduling timer "check-buildbucket-build-status" (chromium-m157/linux-official:8833292094076768896:23:0) after 3m48s
[17:41:18.395] Received PubSub notification, asking Buildbucket for the build status
[17:41:18.473] Build:
{
"id": "8667862031925309937",
"builder": {
"project": "chromium-m157",
"bucket": "ci",
"builder": "linux-official"
},
"number": 25,
"createdBy": "project:chromium-m157",
"createTime": "2026-10-15T15:53:44.207221534Z",
"startTime": "2026-10-15T16:16:51.549564223Z",
"endTime": "2026-10-15T17:41:17.027464121Z",
"updateTime": "2026-10-15T17:41:17.027464121Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "a0436424ed50748d25a82f230d39502a1ebffed1",
"ref": "refs/branch-heads/8103"
}
}
}
[17:41:18.473] Invocation finished in 1h47m35.70058518s with status SUCCEEDED