[07:00:06.493] New invocation is queued and will start shortly
[07:00:08.170] Starting the invocation (attempt 1)
[07:00:08.198] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5dacdee74119261420081db5362e8dadab855f4a"
[07:00:08.198] Popped gitiles commit info from properties and tags
[07:00:08.198] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:00:08.198] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:00:08.198] Buildbucket request:
{
"requestId": "8835409395809763568",
"builder": {
"project": "chromium-m152",
"bucket": "ci",
"builder": "chromeos-amd64-generic-dbg"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8835409395809763568",
"job": "chromium-m152/chromeos-amd64-generic-dbg",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7977",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "5dacdee74119261420081db5362e8dadab855f4a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7977@5dacdee74119261420081db5362e8dadab855f4a",
"title": "5dacdee74119261420081db5362e8dadab855f4a",
"url": "https://chromium.googlesource.com/chromium/src/+/5dacdee74119261420081db5362e8dadab855f4a"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5dacdee74119261420081db5362e8dadab855f4a",
"ref": "refs/branch-heads/7977"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8835409395809763568"
},
{
"key": "scheduler_job_id",
"value": "chromium-m152/chromeos-amd64-generic-dbg"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[07:00:10.264] Scheduled build:
{
"id": "8669979333269131057",
"builder": {
"project": "chromium-m152",
"bucket": "ci",
"builder": "chromeos-amd64-generic-dbg"
},
"number": 1732,
"createdBy": "project:chromium-m152",
"createTime": "2026-09-22T07:00:08.296752679Z",
"updateTime": "2026-09-22T07:00:08.296752679Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5dacdee74119261420081db5362e8dadab855f4a",
"ref": "refs/branch-heads/7977"
}
}
}
[07:00:10.264] Task URL: https://cr-buildbucket.appspot.com/build/8669979333269131057
[07:00:10.264] Scheduling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:2:0) after 6m3s
[07:00:45.293] Received PubSub notification, asking Buildbucket for the build status
[07:00:45.455] Build status: SCHEDULED
[07:06:13.294] Handling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:2:0)
[07:06:13.316] Build status: SCHEDULED
[07:06:13.316] Scheduling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:4:0) after 3m5s
[07:09:18.332] Handling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:4:0)
[07:09:18.354] Build status: SCHEDULED
[07:09:18.354] Scheduling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:5:0) after 1m33s
[07:10:51.384] Handling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:5:0)
[07:10:51.430] Build status: SCHEDULED
[07:10:51.430] Scheduling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:6:0) after 3m7s
[07:13:58.659] Handling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:6:0)
[07:13:58.676] Build status: SCHEDULED
[07:13:58.676] Scheduling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:7:0) after 3m32s
[07:17:30.690] Handling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:7:0)
[07:17:30.711] Build status: SCHEDULED
[07:17:30.711] Scheduling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:8:0) after 4m33s
[07:22:03.748] Handling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:8:0)
[07:22:03.767] Build status: SCHEDULED
[07:22:03.767] Scheduling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:9:0) after 3m56s
[07:25:59.833] Handling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:9:0)
[07:25:59.851] Build status: SCHEDULED
[07:25:59.852] Scheduling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:10:0) after 1m0s
[07:26:59.854] Handling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:10:0)
[07:26:59.873] Build status: SCHEDULED
[07:26:59.873] Scheduling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:11:0) after 9m0s
[07:35:59.989] Handling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:11:0)
[07:36:00.059] Build status: SCHEDULED
[07:36:00.060] Scheduling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:12:0) after 4m42s
[07:40:42.125] Handling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:12:0)
[07:40:42.147] Build status: SCHEDULED
[07:40:42.147] Scheduling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:13:0) after 1m15s
[07:41:57.162] Handling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:13:0)
[07:41:57.201] Build status: SCHEDULED
[07:41:57.201] Scheduling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:14:0) after 5m3s
[07:47:00.233] Handling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:14:0)
[07:47:00.263] Build status: SCHEDULED
[07:47:00.263] Scheduling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:15:0) after 1m38s
[07:48:38.298] Handling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:15:0)
[07:48:38.315] Build status: SCHEDULED
[07:48:38.315] Scheduling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:16:0) after 5m46s
[07:54:24.410] Handling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:16:0)
[07:54:24.457] Build status: SCHEDULED
[07:54:24.457] Scheduling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:17:0) after 7m59s
[08:01:23.224] Received PubSub notification, asking Buildbucket for the build status
[08:01:23.268] Build status: STARTED
[08:02:23.589] Handling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:17:0)
[08:02:23.618] Build status: STARTED
[08:02:23.618] Scheduling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:19:0) after 4m50s
[08:07:13.632] Handling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:19:0)
[08:07:13.650] Build status: STARTED
[08:07:13.650] Scheduling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:20:0) after 4m49s
[08:12:02.681] Handling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:20:0)
[08:12:02.756] Build status: STARTED
[08:12:02.756] Scheduling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:21:0) after 3m48s
[08:15:50.739] Handling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:21:0)
[08:15:50.760] Build status: STARTED
[08:15:50.760] Scheduling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:22:0) after 3m28s
[08:19:18.966] Handling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:22:0)
[08:19:18.987] Build status: STARTED
[08:19:18.987] Scheduling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:23:0) after 2m0s
[08:21:19.003] Handling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:23:0)
[08:21:19.023] Build status: STARTED
[08:21:19.023] Scheduling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:24:0) after 6m56s
[08:28:15.037] Handling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:24:0)
[08:28:15.083] Build status: STARTED
[08:28:15.083] Scheduling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:25:0) after 9m10s
[08:37:25.200] Handling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:25:0)
[08:37:25.223] Build status: STARTED
[08:37:25.223] Scheduling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:26:0) after 7m45s
[08:45:10.258] Handling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:26:0)
[08:45:10.277] Build status: STARTED
[08:45:10.277] Scheduling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:27:0) after 6m10s
[08:51:20.291] Handling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:27:0)
[08:51:20.310] Build status: STARTED
[08:51:20.310] Scheduling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:28:0) after 6m41s
[08:58:01.307] Handling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:28:0)
[08:58:01.330] Build status: STARTED
[08:58:01.330] Scheduling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:29:0) after 2m37s
[09:00:38.346] Handling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:29:0)
[09:00:38.367] Build status: STARTED
[09:00:38.367] Scheduling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:30:0) after 3m21s
[09:03:59.383] Handling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:30:0)
[09:03:59.408] Build status: STARTED
[09:03:59.409] Scheduling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:31:0) after 1m19s
[09:05:18.438] Handling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:31:0)
[09:05:18.459] Build status: STARTED
[09:05:18.459] Scheduling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:32:0) after 4m57s
[09:10:15.473] Handling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:32:0)
[09:10:15.490] Build status: STARTED
[09:10:15.490] Scheduling timer "check-buildbucket-build-status" (chromium-m152/chromeos-amd64-generic-dbg:8835409395809763568:33:0) after 8m42s
[09:16:32.356] Received PubSub notification, asking Buildbucket for the build status
[09:16:32.379] Build:
{
"id": "8669979333269131057",
"builder": {
"project": "chromium-m152",
"bucket": "ci",
"builder": "chromeos-amd64-generic-dbg"
},
"number": 1732,
"createdBy": "project:chromium-m152",
"createTime": "2026-09-22T07:00:08.296752679Z",
"startTime": "2026-09-22T08:01:05.054229554Z",
"endTime": "2026-09-22T09:16:30.732085766Z",
"updateTime": "2026-09-22T09:16:30.732085766Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5dacdee74119261420081db5362e8dadab855f4a",
"ref": "refs/branch-heads/7977"
}
}
}
[09:16:32.379] Invocation finished in 2h16m25.889548404s with status SUCCEEDED