[13:32:58.065] New invocation is queued and will start shortly
[13:32:59.172] Starting the invocation (attempt 1)
[13:32:59.205] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bd29900f7bf6c2f201ca70f1429d21aec2819516"
[13:32:59.205] Popped gitiles commit info from properties and tags
[13:32:59.205] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[13:32:59.207] PubSub topic is "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
[13:32:59.207] Buildbucket request:
{
"requestId": "8856403175431457696",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win11-rel-dev"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "bd29900f7bf6c2f201ca70f1429d21aec2819516",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8856403175431457696"
},
{
"key": "scheduler_job_id",
"value": "chromium/win11-rel-dev"
},
{
"key": "user_agent",
"value": "luci-scheduler-dev"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
}
}
[13:33:00.048] Scheduled build:
{
"id": "8690973113520679409",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win11-rel-dev"
},
"number": 18560,
"createdBy": "project:chromium",
"createTime": "2026-02-02T13:32:59.266360179Z",
"updateTime": "2026-02-02T13:32:59.266360179Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "bd29900f7bf6c2f201ca70f1429d21aec2819516",
"ref": "refs/heads/main"
}
}
}
[13:33:00.048] Task URL: https://cr-buildbucket-dev.appspot.com/build/8690973113520679409
[13:33:00.049] Scheduling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:2:0) after 8m44s
[13:33:01.010] Received PubSub notification, asking Buildbucket for the build status
[13:33:01.044] Build status: SCHEDULED
[13:39:42.177] Received PubSub notification, asking Buildbucket for the build status
[13:39:42.197] Build status: STARTED
[13:41:44.061] Handling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:2:0)
[13:41:44.237] Build status: STARTED
[13:41:44.237] Scheduling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:5:0) after 1m17s
[13:43:01.254] Handling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:5:0)
[13:43:01.279] Build status: STARTED
[13:43:01.279] Scheduling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:6:0) after 4m4s
[13:47:05.299] Handling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:6:0)
[13:47:05.340] Build status: STARTED
[13:47:05.340] Scheduling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:7:0) after 3m9s
[13:50:14.357] Handling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:7:0)
[13:50:14.380] Build status: STARTED
[13:50:14.380] Scheduling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:8:0) after 2m3s
[13:52:17.399] Handling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:8:0)
[13:52:17.420] Build status: STARTED
[13:52:17.420] Scheduling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:9:0) after 6m14s
[13:58:31.434] Handling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:9:0)
[13:58:31.456] Build status: STARTED
[13:58:31.456] Scheduling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:10:0) after 9m52s
[14:08:23.476] Handling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:10:0)
[14:08:23.496] Build status: STARTED
[14:08:23.496] Scheduling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:11:0) after 4m44s
[14:13:07.522] Handling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:11:0)
[14:13:07.544] Build status: STARTED
[14:13:07.544] Scheduling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:12:0) after 5m2s
[14:18:09.561] Handling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:12:0)
[14:18:09.582] Build status: STARTED
[14:18:09.582] Scheduling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:13:0) after 2m52s
[14:21:01.617] Handling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:13:0)
[14:21:01.669] Build status: STARTED
[14:21:01.669] Scheduling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:14:0) after 8m3s
[14:29:04.695] Handling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:14:0)
[14:29:04.716] Build status: STARTED
[14:29:04.716] Scheduling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:15:0) after 9m43s
[14:38:47.748] Handling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:15:0)
[14:38:47.772] Build status: STARTED
[14:38:47.772] Scheduling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:16:0) after 4m50s
[14:43:37.797] Handling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:16:0)
[14:43:37.822] Build status: STARTED
[14:43:37.822] Scheduling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:17:0) after 1m26s
[14:45:03.838] Handling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:17:0)
[14:45:03.858] Build status: STARTED
[14:45:03.859] Scheduling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:18:0) after 4m7s
[14:49:10.875] Handling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:18:0)
[14:49:10.904] Build status: STARTED
[14:49:10.904] Scheduling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:19:0) after 7m51s
[14:57:01.922] Handling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:19:0)
[14:57:01.944] Build status: STARTED
[14:57:01.944] Scheduling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:20:0) after 9m43s
[15:06:44.959] Handling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:20:0)
[15:06:44.988] Build status: STARTED
[15:06:44.988] Scheduling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:21:0) after 2m48s
[15:09:33.848] Handling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:21:0)
[15:09:33.872] Build status: STARTED
[15:09:33.872] Scheduling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:22:0) after 5m47s
[15:15:20.891] Handling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:22:0)
[15:15:20.913] Build status: STARTED
[15:15:20.913] Scheduling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:23:0) after 7m6s
[15:22:26.936] Handling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:23:0)
[15:22:26.954] Build status: STARTED
[15:22:26.954] Scheduling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:24:0) after 1m27s
[15:23:53.968] Handling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:24:0)
[15:23:53.986] Build status: STARTED
[15:23:53.986] Scheduling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:25:0) after 9m1s
[15:32:55.002] Handling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:25:0)
[15:32:55.023] Build status: STARTED
[15:32:55.023] Scheduling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:26:0) after 3m24s
[15:36:19.040] Handling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:26:0)
[15:36:19.067] Build status: STARTED
[15:36:19.067] Scheduling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:27:0) after 8m57s
[15:45:16.084] Handling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:27:0)
[15:45:16.108] Build status: STARTED
[15:45:16.108] Scheduling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:28:0) after 3m18s
[15:48:34.127] Handling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:28:0)
[15:48:34.148] Build status: STARTED
[15:48:34.149] Scheduling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:29:0) after 1m49s
[15:50:23.166] Handling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:29:0)
[15:50:23.190] Build status: STARTED
[15:50:23.190] Scheduling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:30:0) after 9m38s
[16:00:01.206] Handling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:30:0)
[16:00:01.228] Build status: STARTED
[16:00:01.228] Scheduling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:31:0) after 6m23s
[16:06:24.248] Handling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:31:0)
[16:06:24.280] Build status: STARTED
[16:06:24.280] Scheduling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:32:0) after 7m5s
[16:13:29.296] Handling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:32:0)
[16:13:29.316] Build status: STARTED
[16:13:29.316] Scheduling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:33:0) after 3m25s
[16:16:54.332] Handling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:33:0)
[16:16:54.463] Build status: STARTED
[16:16:54.463] Scheduling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:34:0) after 7m31s
[16:24:25.481] Handling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:34:0)
[16:24:25.501] Build status: STARTED
[16:24:25.501] Scheduling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:35:0) after 1m32s
[16:25:57.519] Handling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:35:0)
[16:25:57.596] Build status: STARTED
[16:25:57.596] Scheduling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:36:0) after 9m4s
[16:35:01.614] Handling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:36:0)
[16:35:01.637] Build status: STARTED
[16:35:01.637] Scheduling timer "check-buildbucket-build-status" (chromium/win11-rel-dev:8856403175431457696:37:0) after 7m13s
[16:41:22.510] Received PubSub notification, asking Buildbucket for the build status
[16:41:22.654] Build:
{
"id": "8690973113520679409",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win11-rel-dev"
},
"number": 18560,
"createdBy": "project:chromium",
"createTime": "2026-02-02T13:32:59.266360179Z",
"startTime": "2026-02-02T13:39:41.981913078Z",
"endTime": "2026-02-02T16:40:50.348011459Z",
"updateTime": "2026-02-02T16:40:50.348011459Z",
"status": "INFRA_FAILURE",
"statusDetails": {
"timeout": {
}
},
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "bd29900f7bf6c2f201ca70f1429d21aec2819516",
"ref": "refs/heads/main"
}
}
}
[16:41:22.654] Invocation finished in 3h8m24.594438127s with status FAILED