[08:02:08.335] New invocation is queued and will start shortly
[08:02:09.503] Starting the invocation (attempt 1)
[08:02:09.528] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/12a0b53d4f9cd0a27e9f3ae331d4979653b13bb0"
[08:02:09.528] Popped gitiles commit info from properties and tags
[08:02:09.528] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:02:09.528] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:02:09.528] Buildbucket request:
{
"requestId": "8853071901624673424",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win32-official"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "12a0b53d4f9cd0a27e9f3ae331d4979653b13bb0",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8853071901624673424"
},
{
"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"
}
}
[08:02:10.185] Scheduled build:
{
"id": "8687641839579852577",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win32-official"
},
"number": 11511,
"createdBy": "project:chromium",
"createTime": "2026-03-11T08:02:09.664158202Z",
"updateTime": "2026-03-11T08:02:09.664158202Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "12a0b53d4f9cd0a27e9f3ae331d4979653b13bb0",
"ref": "refs/heads/main"
}
},
"canary": true
}
[08:02:10.185] Task URL: https://cr-buildbucket.appspot.com/build/8687641839579852577
[08:02:10.185] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:2:0) after 9m48s
[08:02:16.574] Received PubSub notification, asking Buildbucket for the build status
[08:02:16.597] Build status: STARTED
[08:02:19.517] Received PubSub notification, asking Buildbucket for the build status
[08:02:19.569] Build status: STARTED
[08:11:58.217] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:2:0)
[08:11:58.237] Build status: STARTED
[08:11:58.237] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:5:0) after 4m17s
[08:16:15.262] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:5:0)
[08:16:15.287] Build status: STARTED
[08:16:15.287] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:6:0) after 2m5s
[08:18:20.258] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:6:0)
[08:18:20.275] Build status: STARTED
[08:18:20.275] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:7:0) after 7m1s
[08:25:21.424] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:7:0)
[08:25:21.453] Build status: STARTED
[08:25:21.453] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:8:0) after 8m29s
[08:33:50.472] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:8:0)
[08:33:50.500] Build status: STARTED
[08:33:50.500] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:9:0) after 4m56s
[08:38:46.492] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:9:0)
[08:38:46.510] Build status: STARTED
[08:38:46.510] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:10:0) after 6m22s
[08:45:08.587] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:10:0)
[08:45:08.611] Build status: STARTED
[08:45:08.612] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:11:0) after 2m29s
[08:47:37.608] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:11:0)
[08:47:37.625] Build status: STARTED
[08:47:37.625] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:12:0) after 2m5s
[08:49:42.822] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:12:0)
[08:49:42.843] Build status: STARTED
[08:49:42.843] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:13:0) after 2m32s
[08:52:14.862] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:13:0)
[08:52:14.889] Build status: STARTED
[08:52:14.889] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:14:0) after 7m7s
[08:59:21.957] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:14:0)
[08:59:21.979] Build status: STARTED
[08:59:21.979] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:15:0) after 7m5s
[09:06:27.000] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:15:0)
[09:06:27.022] Build status: STARTED
[09:06:27.022] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:16:0) after 1m47s
[09:08:14.096] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:16:0)
[09:08:14.114] Build status: STARTED
[09:08:14.114] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:17:0) after 1m42s
[09:09:56.131] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:17:0)
[09:09:56.162] Build status: STARTED
[09:09:56.162] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:18:0) after 2m17s
[09:12:13.190] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:18:0)
[09:12:13.207] Build status: STARTED
[09:12:13.207] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:19:0) after 9m23s
[09:21:36.258] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:19:0)
[09:21:36.280] Build status: STARTED
[09:21:36.280] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:20:0) after 1m40s
[09:23:16.296] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:20:0)
[09:23:16.331] Build status: STARTED
[09:23:16.331] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:21:0) after 2m16s
[09:25:32.400] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:21:0)
[09:25:32.459] Build status: STARTED
[09:25:32.460] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:22:0) after 9m22s
[09:34:54.649] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:22:0)
[09:34:54.663] Build status: STARTED
[09:34:54.663] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:23:0) after 1m55s
[09:36:49.720] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:23:0)
[09:36:49.735] Build status: STARTED
[09:36:49.735] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:24:0) after 5m47s
[09:42:36.756] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:24:0)
[09:42:36.776] Build status: STARTED
[09:42:36.776] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:25:0) after 9m9s
[09:51:45.821] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:25:0)
[09:51:45.835] Build status: STARTED
[09:51:45.835] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:26:0) after 6m30s
[09:58:15.906] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:26:0)
[09:58:15.924] Build status: STARTED
[09:58:15.924] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:27:0) after 9m15s
[10:07:30.973] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:27:0)
[10:07:31.001] Build status: STARTED
[10:07:31.001] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:28:0) after 6m58s
[10:14:29.022] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:28:0)
[10:14:29.070] Build status: STARTED
[10:14:29.071] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:29:0) after 1m41s
[10:16:10.086] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:29:0)
[10:16:10.125] Build status: STARTED
[10:16:10.125] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:30:0) after 8m5s
[10:24:15.150] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:30:0)
[10:24:15.176] Build status: STARTED
[10:24:15.176] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:31:0) after 7m48s
[10:32:03.202] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:31:0)
[10:32:03.220] Build status: STARTED
[10:32:03.220] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:32:0) after 7m54s
[10:39:57.287] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:32:0)
[10:39:57.358] Build status: STARTED
[10:39:57.358] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:33:0) after 2m20s
[10:42:17.532] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:33:0)
[10:42:17.548] Build status: STARTED
[10:42:17.548] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:34:0) after 3m16s
[10:45:33.568] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:34:0)
[10:45:33.585] Build status: STARTED
[10:45:33.585] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:35:0) after 1m30s
[10:47:03.603] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:35:0)
[10:47:03.625] Build status: STARTED
[10:47:03.625] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:36:0) after 3m18s
[10:50:21.642] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:36:0)
[10:50:21.658] Build status: STARTED
[10:50:21.658] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:37:0) after 5m35s
[10:55:56.681] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:37:0)
[10:55:56.766] Build status: STARTED
[10:55:56.766] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:38:0) after 2m59s
[10:58:55.784] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:38:0)
[10:58:55.802] Build status: STARTED
[10:58:55.802] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:39:0) after 1m13s
[11:00:08.819] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:39:0)
[11:00:08.836] Build status: STARTED
[11:00:08.836] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:40:0) after 8m48s
[11:08:56.856] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:40:0)
[11:08:56.894] Build status: STARTED
[11:08:56.894] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:41:0) after 7m7s
[11:16:03.918] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:41:0)
[11:16:03.933] Build status: STARTED
[11:16:03.933] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:42:0) after 2m6s
[11:18:09.955] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:42:0)
[11:18:09.973] Build status: STARTED
[11:18:09.973] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:43:0) after 7m8s
[11:25:18.038] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:43:0)
[11:25:18.060] Build status: STARTED
[11:25:18.060] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:44:0) after 5m31s
[11:30:49.061] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:44:0)
[11:30:49.079] Build status: STARTED
[11:30:49.080] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:45:0) after 2m16s
[11:33:05.091] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:45:0)
[11:33:05.117] Build status: STARTED
[11:33:05.117] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:46:0) after 7m48s
[11:40:53.239] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:46:0)
[11:40:53.275] Build status: STARTED
[11:40:53.275] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:47:0) after 8m34s
[11:49:27.344] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:47:0)
[11:49:27.367] Build status: STARTED
[11:49:27.367] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:48:0) after 4m49s
[11:54:16.388] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:48:0)
[11:54:16.406] Build status: STARTED
[11:54:16.406] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:49:0) after 8m54s
[12:03:10.475] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:49:0)
[12:03:10.489] Build status: STARTED
[12:03:10.489] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:50:0) after 3m49s
[12:06:59.523] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:50:0)
[12:06:59.607] Build status: STARTED
[12:06:59.607] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:51:0) after 6m3s
[12:13:02.652] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:51:0)
[12:13:02.668] Build status: STARTED
[12:13:02.668] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:52:0) after 1m30s
[12:14:32.689] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:52:0)
[12:14:32.705] Build status: STARTED
[12:14:32.705] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:53:0) after 6m22s
[12:20:54.684] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:53:0)
[12:20:54.708] Build status: STARTED
[12:20:54.708] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:54:0) after 5m27s
[12:26:21.728] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:54:0)
[12:26:21.751] Build status: STARTED
[12:26:21.751] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:55:0) after 4m46s
[12:31:07.766] Handling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:55:0)
[12:31:07.781] Build status: STARTED
[12:31:07.781] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:8853071901624673424:56:0) after 6m8s
[12:33:06.718] Received PubSub notification, asking Buildbucket for the build status
[12:33:06.740] Build:
{
"id": "8687641839579852577",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win32-official"
},
"number": 11511,
"createdBy": "project:chromium",
"createTime": "2026-03-11T08:02:09.664158202Z",
"startTime": "2026-03-11T08:02:14.874180428Z",
"endTime": "2026-03-11T12:32:30.161670184Z",
"updateTime": "2026-03-11T12:32:30.161670184Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "12a0b53d4f9cd0a27e9f3ae331d4979653b13bb0",
"ref": "refs/heads/main"
}
},
"canary": true
}
[12:33:06.740] Invocation finished in 4h30m58.409526935s with status SUCCEEDED