[02:28:32.159] New invocation is queued and will start shortly
[02:28:33.224] Starting the invocation (attempt 1)
[02:28:33.250] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b187cfcb984e8dffb41045076211e34945e4c072"
[02:28:33.250] Popped gitiles commit info from properties and tags
[02:28:33.250] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:28:33.250] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:28:33.250] Buildbucket request:
{
"requestId": "8844576775264578096",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win32-official"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b187cfcb984e8dffb41045076211e34945e4c072",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8844576775264578096"
},
{
"key": "scheduler_job_id",
"value": "chromium/win32-official"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[02:28:33.927] Scheduled build:
{
"id": "8679146713252362673",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win32-official"
},
"number": 12009,
"createdBy": "project:chromium",
"createTime": "2026-06-13T02:28:33.457201693Z",
"updateTime": "2026-06-13T02:28:33.457201693Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b187cfcb984e8dffb41045076211e34945e4c072",
"ref": "refs/heads/main"
}
}
}
[02:28:33.927] Task URL: https://cr-buildbucket.appspot.com/build/8679146713252362673
[02:28:33.927] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:2:0) after 6m23s
[02:28:34.052] Received PubSub notification, asking Buildbucket for the build status
[02:28:34.076] Build status: SCHEDULED
[02:28:39.337] Received PubSub notification, asking Buildbucket for the build status
[02:28:39.357] Build status: STARTED
[02:34:57.224] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:2:0)
[02:34:57.242] Build status: STARTED
[02:34:57.242] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:5:0) after 4m46s
[02:39:43.302] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:5:0)
[02:39:43.350] Build status: STARTED
[02:39:43.350] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:6:0) after 6m37s
[02:46:20.371] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:6:0)
[02:46:20.428] Build status: STARTED
[02:46:20.428] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:7:0) after 8m10s
[02:54:30.468] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:7:0)
[02:54:30.507] Build status: STARTED
[02:54:30.507] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:8:0) after 3m46s
[02:58:16.498] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:8:0)
[02:58:16.515] Build status: STARTED
[02:58:16.515] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:9:0) after 1m5s
[02:59:21.569] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:9:0)
[02:59:21.592] Build status: STARTED
[02:59:21.592] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:10:0) after 5m51s
[03:05:12.611] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:10:0)
[03:05:12.684] Build status: STARTED
[03:05:12.685] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:11:0) after 4m57s
[03:10:09.705] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:11:0)
[03:10:09.732] Build status: STARTED
[03:10:09.732] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:12:0) after 3m40s
[03:13:49.752] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:12:0)
[03:13:49.773] Build status: STARTED
[03:13:49.773] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:13:0) after 1m20s
[03:15:09.828] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:13:0)
[03:15:09.882] Build status: STARTED
[03:15:09.882] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:14:0) after 6m11s
[03:21:20.898] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:14:0)
[03:21:20.961] Build status: STARTED
[03:21:20.961] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:15:0) after 6m49s
[03:28:10.063] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:15:0)
[03:28:10.077] Build status: STARTED
[03:28:10.077] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:16:0) after 5m47s
[03:33:57.093] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:16:0)
[03:33:57.113] Build status: STARTED
[03:33:57.113] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:17:0) after 4m57s
[03:38:54.128] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:17:0)
[03:38:54.176] Build status: STARTED
[03:38:54.176] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:18:0) after 1m17s
[03:40:11.194] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:18:0)
[03:40:11.228] Build status: STARTED
[03:40:11.228] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:19:0) after 1m45s
[03:41:56.246] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:19:0)
[03:41:56.297] Build status: STARTED
[03:41:56.297] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:20:0) after 4m53s
[03:46:49.316] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:20:0)
[03:46:49.337] Build status: STARTED
[03:46:49.337] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:21:0) after 1m1s
[03:47:50.385] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:21:0)
[03:47:50.465] Build status: STARTED
[03:47:50.465] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:22:0) after 4m59s
[03:52:49.481] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:22:0)
[03:52:49.501] Build status: STARTED
[03:52:49.501] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:23:0) after 8m31s
[04:01:20.518] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:23:0)
[04:01:20.535] Build status: STARTED
[04:01:20.535] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:24:0) after 7m6s
[04:08:26.933] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:24:0)
[04:08:26.955] Build status: STARTED
[04:08:26.955] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:25:0) after 7m49s
[04:16:15.981] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:25:0)
[04:16:16.055] Build status: STARTED
[04:16:16.055] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:26:0) after 5m32s
[04:21:48.232] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:26:0)
[04:21:48.251] Build status: STARTED
[04:21:48.251] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:27:0) after 8m41s
[04:30:29.370] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:27:0)
[04:30:29.447] Build status: STARTED
[04:30:29.447] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:28:0) after 1m43s
[04:32:12.448] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:28:0)
[04:32:12.465] Build status: STARTED
[04:32:12.465] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:29:0) after 8m27s
[04:40:39.550] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:29:0)
[04:40:39.571] Build status: STARTED
[04:40:39.571] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:30:0) after 6m41s
[04:47:20.768] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:30:0)
[04:47:20.792] Build status: STARTED
[04:47:20.792] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:31:0) after 6m58s
[04:54:18.763] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:31:0)
[04:54:18.781] Build status: STARTED
[04:54:18.781] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:32:0) after 8m24s
[05:02:43.176] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:32:0)
[05:02:43.217] Build status: STARTED
[05:02:43.217] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:33:0) after 6m36s
[05:09:19.520] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:33:0)
[05:09:19.544] Build status: STARTED
[05:09:19.544] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:34:0) after 1m17s
[05:10:36.584] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:34:0)
[05:10:36.656] Build status: STARTED
[05:10:36.656] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:35:0) after 2m28s
[05:13:04.718] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:35:0)
[05:13:04.745] Build status: STARTED
[05:13:04.745] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:36:0) after 9m15s
[05:22:19.847] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:36:0)
[05:22:19.907] Build status: STARTED
[05:22:19.907] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:37:0) after 5m28s
[05:27:48.302] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:37:0)
[05:27:48.322] Build status: STARTED
[05:27:48.322] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:38:0) after 1m26s
[05:29:14.339] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:38:0)
[05:29:14.542] Build status: STARTED
[05:29:14.542] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:39:0) after 7m57s
[05:37:11.564] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:39:0)
[05:37:11.637] Build status: STARTED
[05:37:11.637] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:40:0) after 1m35s
[05:38:46.754] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:40:0)
[05:38:46.862] Build status: STARTED
[05:38:46.862] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:41:0) after 7m38s
[05:46:25.033] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:41:0)
[05:46:25.074] Build status: STARTED
[05:46:25.074] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:42:0) after 1m57s
[05:48:22.311] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:42:0)
[05:48:22.328] Build status: STARTED
[05:48:22.328] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:43:0) after 2m46s
[05:51:08.345] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:43:0)
[05:51:08.363] Build status: STARTED
[05:51:08.363] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:44:0) after 1m6s
[05:52:14.391] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:44:0)
[05:52:14.404] Build status: STARTED
[05:52:14.404] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:45:0) after 3m46s
[05:56:00.539] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:45:0)
[05:56:00.617] Build status: STARTED
[05:56:00.617] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:46:0) after 8m43s
[06:04:43.792] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:46:0)
[06:04:43.816] Build status: STARTED
[06:04:43.816] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:47:0) after 9m58s
[06:14:41.926] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:47:0)
[06:14:41.944] Build status: STARTED
[06:14:41.944] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:48:0) after 9m54s
[06:24:36.117] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:48:0)
[06:24:36.135] Build status: STARTED
[06:24:36.135] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:49:0) after 6m59s
[06:31:35.152] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:49:0)
[06:31:35.176] Build status: STARTED
[06:31:35.176] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:50:0) after 7m57s
[06:39:32.193] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:50:0)
[06:39:32.208] Build status: STARTED
[06:39:32.208] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:51:0) after 5m28s
[06:45:00.242] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:51:0)
[06:45:00.275] Build status: STARTED
[06:45:00.275] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:52:0) after 6m1s
[06:51:01.374] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:52:0)
[06:51:01.416] Build status: STARTED
[06:51:01.416] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:53:0) after 2m5s
[06:53:06.783] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:53:0)
[06:53:06.798] Build status: STARTED
[06:53:06.798] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:54:0) after 4m39s
[06:57:45.903] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:54:0)
[06:57:45.955] Build status: STARTED
[06:57:45.956] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:55:0) after 2m13s
[06:59:58.986] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:55:0)
[06:59:59.017] Build status: STARTED
[06:59:59.017] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:56:0) after 7m16s
[07:07:15.036] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:56:0)
[07:07:15.053] Build status: STARTED
[07:07:15.053] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:57:0) after 8m38s
[07:15:53.109] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:57:0)
[07:15:53.300] Build status: STARTED
[07:15:53.300] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:58:0) after 3m15s
[07:19:08.380] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:58:0)
[07:19:08.530] Build status: STARTED
[07:19:08.530] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:59:0) after 8m34s
[07:27:42.616] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:59:0)
[07:27:42.638] Build status: STARTED
[07:27:42.638] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8844576775264578096:60:0) after 4m39s
[07:31:28.578] Received PubSub notification, asking Buildbucket for the build status
[07:31:28.592] Build:
{
"id": "8679146713252362673",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win32-official"
},
"number": 12009,
"createdBy": "project:chromium",
"createTime": "2026-06-13T02:28:33.457201693Z",
"startTime": "2026-06-13T02:28:39.145394606Z",
"endTime": "2026-06-13T07:31:18.744737484Z",
"updateTime": "2026-06-13T07:31:18.744737484Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b187cfcb984e8dffb41045076211e34945e4c072",
"ref": "refs/heads/main"
}
}
}
[07:31:28.592] Invocation finished in 5h2m56.437800416s with status SUCCEEDED