[06:00:42.586] New invocation is queued and will start shortly
[06:00:43.660] Starting the invocation (attempt 1)
[06:00:43.695] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/aafc51f688871d5bd68b0ee8c90274a9ab8041fd"
[06:00:43.695] Popped gitiles commit info from properties and tags
[06:00:43.695] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:00:43.695] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:00:43.695] Buildbucket request:
{
"requestId": "8850542826225747136",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win-arm64-rel"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "aafc51f688871d5bd68b0ee8c90274a9ab8041fd",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8850542826225747136"
},
{
"key": "scheduler_job_id",
"value": "chromium/win-arm64-rel"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[06:00:44.305] Scheduled build:
{
"id": "8685112764266887473",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win-arm64-rel"
},
"number": 7072,
"createdBy": "project:chromium",
"createTime": "2026-04-08T06:00:43.834767924Z",
"updateTime": "2026-04-08T06:00:43.834767924Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "aafc51f688871d5bd68b0ee8c90274a9ab8041fd",
"ref": "refs/heads/main"
}
}
}
[06:00:44.305] Task URL: https://cr-buildbucket.appspot.com/build/8685112764266887473
[06:00:44.305] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:2:0) after 9m33s
[06:00:52.210] Received PubSub notification, asking Buildbucket for the build status
[06:00:52.227] Build status: STARTED
[06:00:56.998] Received PubSub notification, asking Buildbucket for the build status
[06:00:57.019] Build status: STARTED
[06:10:17.473] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:2:0)
[06:10:17.502] Build status: STARTED
[06:10:17.502] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:5:0) after 4m32s
[06:14:49.518] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:5:0)
[06:14:49.533] Build status: STARTED
[06:14:49.533] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:6:0) after 6m20s
[06:21:09.516] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:6:0)
[06:21:09.572] Build status: STARTED
[06:21:09.572] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:7:0) after 7m9s
[06:28:18.624] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:7:0)
[06:28:18.731] Build status: STARTED
[06:28:18.731] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:8:0) after 7m11s
[06:35:29.829] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:8:0)
[06:35:29.846] Build status: STARTED
[06:35:29.846] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:9:0) after 6m35s
[06:42:04.860] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:9:0)
[06:42:04.877] Build status: STARTED
[06:42:04.877] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:10:0) after 4m55s
[06:46:59.897] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:10:0)
[06:46:59.918] Build status: STARTED
[06:46:59.918] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:11:0) after 1m11s
[06:48:10.920] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:11:0)
[06:48:10.945] Build status: STARTED
[06:48:10.945] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:12:0) after 8m56s
[06:57:06.933] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:12:0)
[06:57:06.980] Build status: STARTED
[06:57:06.980] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:13:0) after 1m38s
[06:58:45.049] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:13:0)
[06:58:45.068] Build status: STARTED
[06:58:45.068] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:14:0) after 9m58s
[07:08:43.097] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:14:0)
[07:08:43.176] Build status: STARTED
[07:08:43.176] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:15:0) after 7m23s
[07:16:06.197] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:15:0)
[07:16:06.241] Build status: STARTED
[07:16:06.241] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:16:0) after 5m21s
[07:21:27.300] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:16:0)
[07:21:27.320] Build status: STARTED
[07:21:27.320] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:17:0) after 2m16s
[07:23:43.386] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:17:0)
[07:23:43.402] Build status: STARTED
[07:23:43.402] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:18:0) after 8m58s
[07:32:41.418] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:18:0)
[07:32:41.483] Build status: STARTED
[07:32:41.483] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:19:0) after 4m8s
[07:36:49.504] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:19:0)
[07:36:49.533] Build status: STARTED
[07:36:49.533] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:20:0) after 3m29s
[07:40:18.602] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:20:0)
[07:40:18.620] Build status: STARTED
[07:40:18.620] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:21:0) after 1m10s
[07:41:28.626] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:21:0)
[07:41:28.776] Build status: STARTED
[07:41:28.776] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:22:0) after 2m59s
[07:44:27.858] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:22:0)
[07:44:27.878] Build status: STARTED
[07:44:27.878] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:23:0) after 8m9s
[07:52:37.162] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:23:0)
[07:52:37.254] Build status: STARTED
[07:52:37.254] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:24:0) after 1m45s
[07:54:22.271] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:24:0)
[07:54:22.289] Build status: STARTED
[07:54:22.289] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:25:0) after 5m5s
[07:59:27.313] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:25:0)
[07:59:27.337] Build status: STARTED
[07:59:27.337] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:26:0) after 7m41s
[08:07:08.424] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:26:0)
[08:07:08.527] Build status: STARTED
[08:07:08.528] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:27:0) after 7m9s
[08:14:17.649] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:27:0)
[08:14:17.666] Build status: STARTED
[08:14:17.666] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:28:0) after 2m46s
[08:17:03.733] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:28:0)
[08:17:03.748] Build status: STARTED
[08:17:03.748] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:29:0) after 8m43s
[08:25:46.771] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:29:0)
[08:25:46.790] Build status: STARTED
[08:25:46.790] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:30:0) after 9m10s
[08:34:56.809] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:30:0)
[08:34:56.826] Build status: STARTED
[08:34:56.827] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:31:0) after 5m26s
[08:40:22.895] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:31:0)
[08:40:22.972] Build status: STARTED
[08:40:22.972] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:32:0) after 6m57s
[08:47:20.017] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:32:0)
[08:47:20.033] Build status: STARTED
[08:47:20.033] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:33:0) after 6m23s
[08:53:43.097] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:33:0)
[08:53:43.129] Build status: STARTED
[08:53:43.129] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:34:0) after 4m37s
[08:58:20.146] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:34:0)
[08:58:20.165] Build status: STARTED
[08:58:20.165] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:35:0) after 3m7s
[09:01:27.187] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:35:0)
[09:01:27.207] Build status: STARTED
[09:01:27.207] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:36:0) after 9m36s
[09:11:03.244] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:36:0)
[09:11:03.262] Build status: STARTED
[09:11:03.262] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:37:0) after 8m24s
[09:19:27.389] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:37:0)
[09:19:27.406] Build status: STARTED
[09:19:27.406] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:38:0) after 5m53s
[09:25:20.573] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:38:0)
[09:25:20.594] Build status: STARTED
[09:25:20.594] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:39:0) after 2m46s
[09:28:06.653] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:39:0)
[09:28:06.674] Build status: STARTED
[09:28:06.674] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:40:0) after 7m5s
[09:35:11.728] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:40:0)
[09:35:11.759] Build status: STARTED
[09:35:11.759] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:41:0) after 8m48s
[09:43:59.859] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:41:0)
[09:43:59.882] Build status: STARTED
[09:43:59.882] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:42:0) after 2m15s
[09:46:14.949] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:42:0)
[09:46:15.058] Build status: STARTED
[09:46:15.058] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:43:0) after 6m53s
[09:53:08.250] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:43:0)
[09:53:08.269] Build status: STARTED
[09:53:08.269] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:44:0) after 6m21s
[09:59:29.353] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:44:0)
[09:59:29.373] Build status: STARTED
[09:59:29.373] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:45:0) after 3m40s
[10:03:09.395] Handling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:45:0)
[10:03:09.412] Build status: STARTED
[10:03:09.412] Scheduling timer "check-buildbucket-build-status" (chromium/win-arm64-rel:8850542826225747136:46:0) after 4m3s
[10:04:09.382] Received PubSub notification, asking Buildbucket for the build status
[10:04:09.401] Build:
{
"id": "8685112764266887473",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win-arm64-rel"
},
"number": 7072,
"createdBy": "project:chromium",
"createTime": "2026-04-08T06:00:43.834767924Z",
"startTime": "2026-04-08T06:00:51.158615971Z",
"endTime": "2026-04-08T10:04:09.044585345Z",
"updateTime": "2026-04-08T10:04:09.044585345Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "aafc51f688871d5bd68b0ee8c90274a9ab8041fd",
"ref": "refs/heads/main"
}
}
}
[10:04:09.401] Invocation finished in 4h3m26.81914284s with status SUCCEEDED