[08:50:10.742] New invocation is queued and will start shortly
[08:50:12.387] Starting the invocation (attempt 1)
[08:50:12.420] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/db3253d7e32031f90c41dfa7d3dac90dbec15fdd"
[08:50:12.420] Popped gitiles commit info from properties and tags
[08:50:12.420] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:50:12.420] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:50:12.421] Buildbucket request:
{
"requestId": "8834043516259543552",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTChromeOS"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "db3253d7e32031f90c41dfa7d3dac90dbec15fdd",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8834043516259543552"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTChromeOS"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[08:50:13.010] Scheduled build:
{
"id": "8668613453771948561",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTChromeOS"
},
"number": 23087,
"createdBy": "project:chromium",
"createTime": "2026-10-07T08:50:12.492330384Z",
"updateTime": "2026-10-07T08:50:12.492330384Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "db3253d7e32031f90c41dfa7d3dac90dbec15fdd",
"ref": "refs/heads/main"
}
}
}
[08:50:13.010] Task URL: https://cr-buildbucket.appspot.com/build/8668613453771948561
[08:50:13.010] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:2:0) after 7m51s
[08:50:14.565] Received PubSub notification, asking Buildbucket for the build status
[08:50:14.597] Build status: SCHEDULED
[08:58:04.013] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:2:0)
[08:58:04.044] Build status: SCHEDULED
[08:58:04.044] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:4:0) after 9m13s
[09:01:26.946] Received PubSub notification, asking Buildbucket for the build status
[09:01:27.025] Build status: STARTED
[09:07:17.067] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:4:0)
[09:07:17.088] Build status: STARTED
[09:07:17.088] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:6:0) after 7m39s
[09:14:56.111] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:6:0)
[09:14:56.132] Build status: STARTED
[09:14:56.132] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:7:0) after 9m10s
[09:24:06.147] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:7:0)
[09:24:06.170] Build status: STARTED
[09:24:06.170] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:8:0) after 6m3s
[09:30:09.170] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:8:0)
[09:30:09.195] Build status: STARTED
[09:30:09.195] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:9:0) after 2m46s
[09:32:55.214] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:9:0)
[09:32:55.265] Build status: STARTED
[09:32:55.265] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:10:0) after 4m1s
[09:36:56.328] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:10:0)
[09:36:56.352] Build status: STARTED
[09:36:56.352] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:11:0) after 4m31s
[09:41:27.393] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:11:0)
[09:41:27.498] Build status: STARTED
[09:41:27.498] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:12:0) after 9m39s
[09:51:06.519] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:12:0)
[09:51:06.539] Build status: STARTED
[09:51:06.539] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:13:0) after 7m39s
[09:58:45.616] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:13:0)
[09:58:45.727] Build status: STARTED
[09:58:45.727] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:14:0) after 9m8s
[10:07:53.760] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:14:0)
[10:07:53.848] Build status: STARTED
[10:07:53.848] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:15:0) after 1m18s
[10:09:11.999] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:15:0)
[10:09:12.021] Build status: STARTED
[10:09:12.021] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:16:0) after 6m1s
[10:15:13.045] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:16:0)
[10:15:13.062] Build status: STARTED
[10:15:13.062] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:17:0) after 8m4s
[10:23:17.257] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:17:0)
[10:23:17.277] Build status: STARTED
[10:23:17.277] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:18:0) after 4m37s
[10:27:54.361] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:18:0)
[10:27:54.380] Build status: STARTED
[10:27:54.380] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:19:0) after 5m17s
[10:33:11.512] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:19:0)
[10:33:11.533] Build status: STARTED
[10:33:11.533] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:20:0) after 5m25s
[10:38:36.554] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:20:0)
[10:38:36.573] Build status: STARTED
[10:38:36.573] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:21:0) after 5m39s
[10:44:15.588] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:21:0)
[10:44:15.616] Build status: STARTED
[10:44:15.616] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:22:0) after 4m7s
[10:48:22.631] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:22:0)
[10:48:22.671] Build status: STARTED
[10:48:22.671] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:23:0) after 8m19s
[10:56:41.683] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:23:0)
[10:56:41.704] Build status: STARTED
[10:56:41.704] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:24:0) after 6m32s
[11:03:13.684] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:24:0)
[11:03:13.702] Build status: STARTED
[11:03:13.702] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:25:0) after 2m22s
[11:05:35.785] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:25:0)
[11:05:35.868] Build status: STARTED
[11:05:35.868] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:26:0) after 2m22s
[11:07:57.960] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:26:0)
[11:07:57.988] Build status: STARTED
[11:07:57.988] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:27:0) after 8m4s
[11:16:02.072] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:27:0)
[11:16:02.129] Build status: STARTED
[11:16:02.129] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:28:0) after 4m2s
[11:20:04.203] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:28:0)
[11:20:04.245] Build status: STARTED
[11:20:04.245] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:29:0) after 2m13s
[11:22:17.365] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:29:0)
[11:22:17.391] Build status: STARTED
[11:22:17.391] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:30:0) after 7m30s
[11:29:47.407] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:30:0)
[11:29:47.426] Build status: STARTED
[11:29:47.426] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:31:0) after 9m13s
[11:39:00.447] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:31:0)
[11:39:00.488] Build status: STARTED
[11:39:00.489] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:32:0) after 4m53s
[11:43:53.523] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:32:0)
[11:43:53.543] Build status: STARTED
[11:43:53.543] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:33:0) after 7m14s
[11:51:07.625] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:33:0)
[11:51:07.639] Build status: STARTED
[11:51:07.640] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:34:0) after 9m37s
[12:00:44.694] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:34:0)
[12:00:44.714] Build status: STARTED
[12:00:44.714] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:35:0) after 7m13s
[12:07:57.883] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:35:0)
[12:07:57.900] Build status: STARTED
[12:07:57.900] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:36:0) after 2m11s
[12:10:09.110] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:36:0)
[12:10:09.135] Build status: STARTED
[12:10:09.135] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:37:0) after 7m33s
[12:17:42.199] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:37:0)
[12:17:42.217] Build status: STARTED
[12:17:42.217] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8834043516259543552:38:0) after 1m53s
[12:18:32.578] Received PubSub notification, asking Buildbucket for the build status
[12:18:32.595] Build:
{
"id": "8668613453771948561",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTChromeOS"
},
"number": 23087,
"createdBy": "project:chromium",
"createTime": "2026-10-07T08:50:12.492330384Z",
"startTime": "2026-10-07T09:01:04.575358669Z",
"endTime": "2026-10-07T12:18:32.243953090Z",
"updateTime": "2026-10-07T12:18:32.243953090Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "db3253d7e32031f90c41dfa7d3dac90dbec15fdd",
"ref": "refs/heads/main"
}
}
}
[12:18:32.595] Invocation finished in 3h28m21.859434971s with status SUCCEEDED