[04:00:06.475] New invocation is queued and will start shortly
[04:00:07.837] Starting the invocation (attempt 1)
[04:00:07.866] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3a4c54fe6a6f072d658ddb610c02768cf8c0fcb5"
[04:00:07.866] Popped gitiles commit info from properties and tags
[04:00:07.866] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:00:07.866] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:00:07.866] Buildbucket request:
{
"requestId": "8928644998876416400",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-code-coverage"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "3a4c54fe6a6f072d658ddb610c02768cf8c0fcb5",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8928644998876416400"
},
{
"key": "scheduler_job_id",
"value": "chromium/win10-code-coverage"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[04:00:08.498] Scheduled build:
{
"id": "8763214936686462417",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-code-coverage"
},
"number": 16261,
"createdBy": "project:chromium",
"createTime": "2023-11-28T04:00:07.942742296Z",
"updateTime": "2023-11-28T04:00:07.942742296Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "3a4c54fe6a6f072d658ddb610c02768cf8c0fcb5",
"ref": "refs/heads/main"
}
}
}
[04:00:08.498] Task URL: https://cr-buildbucket.appspot.com/build/8763214936686462417
[04:00:08.498] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:2:0) after 9m27s
[04:00:08.644] Received PubSub notification, asking Buildbucket for the build status
[04:00:08.674] Build status: SCHEDULED
[04:00:11.104] Received PubSub notification, asking Buildbucket for the build status
[04:00:11.251] Build status: STARTED
[04:09:35.707] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:2:0)
[04:09:35.732] Build status: STARTED
[04:09:35.732] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:5:0) after 3m52s
[04:13:28.147] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:5:0)
[04:13:28.196] Build status: STARTED
[04:13:28.196] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:6:0) after 2m26s
[04:15:54.217] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:6:0)
[04:15:54.253] Build status: STARTED
[04:15:54.253] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:7:0) after 4m40s
[04:20:34.751] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:7:0)
[04:20:34.771] Build status: STARTED
[04:20:34.771] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:8:0) after 7m5s
[04:27:40.096] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:8:0)
[04:27:40.116] Build status: STARTED
[04:27:40.116] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:9:0) after 1m24s
[04:29:04.114] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:9:0)
[04:29:04.152] Build status: STARTED
[04:29:04.152] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:10:0) after 5m40s
[04:34:44.337] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:10:0)
[04:34:44.355] Build status: STARTED
[04:34:44.355] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:11:0) after 4m43s
[04:39:27.342] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:11:0)
[04:39:27.374] Build status: STARTED
[04:39:27.374] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:12:0) after 6m4s
[04:45:31.376] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:12:0)
[04:45:31.475] Build status: STARTED
[04:45:31.475] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:13:0) after 3m39s
[04:49:10.825] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:13:0)
[04:49:10.844] Build status: STARTED
[04:49:10.844] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:14:0) after 6m46s
[04:55:56.997] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:14:0)
[04:55:57.028] Build status: STARTED
[04:55:57.028] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:15:0) after 3m40s
[04:59:37.047] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:15:0)
[04:59:37.100] Build status: STARTED
[04:59:37.100] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:16:0) after 4m15s
[05:03:52.129] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:16:0)
[05:03:52.159] Build status: STARTED
[05:03:52.159] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:17:0) after 5m18s
[05:09:10.212] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:17:0)
[05:09:10.228] Build status: STARTED
[05:09:10.228] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:18:0) after 6m12s
[05:15:22.350] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:18:0)
[05:15:22.434] Build status: STARTED
[05:15:22.434] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:19:0) after 1m22s
[05:16:44.535] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:19:0)
[05:16:44.556] Build status: STARTED
[05:16:44.556] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:20:0) after 9m13s
[05:25:57.646] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:20:0)
[05:25:57.667] Build status: STARTED
[05:25:57.667] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:21:0) after 5m15s
[05:31:12.771] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:21:0)
[05:31:12.790] Build status: STARTED
[05:31:12.790] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:22:0) after 1m24s
[05:32:36.917] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:22:0)
[05:32:36.940] Build status: STARTED
[05:32:36.940] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:23:0) after 8m6s
[05:40:42.970] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:23:0)
[05:40:42.988] Build status: STARTED
[05:40:42.988] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:24:0) after 7m49s
[05:48:32.107] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:24:0)
[05:48:32.125] Build status: STARTED
[05:48:32.125] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:25:0) after 9m10s
[05:57:42.278] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:25:0)
[05:57:42.299] Build status: STARTED
[05:57:42.299] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:26:0) after 8m23s
[06:06:05.473] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:26:0)
[06:06:05.494] Build status: STARTED
[06:06:05.494] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:27:0) after 5m59s
[06:12:04.783] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:27:0)
[06:12:04.805] Build status: STARTED
[06:12:04.805] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:28:0) after 7m9s
[06:19:13.955] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:28:0)
[06:19:13.976] Build status: STARTED
[06:19:13.976] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:29:0) after 4m45s
[06:23:59.024] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:29:0)
[06:23:59.051] Build status: STARTED
[06:23:59.051] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:30:0) after 9m19s
[06:33:18.074] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:30:0)
[06:33:18.096] Build status: STARTED
[06:33:18.096] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:31:0) after 1m58s
[06:35:16.223] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:31:0)
[06:35:16.246] Build status: STARTED
[06:35:16.246] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:32:0) after 8m37s
[06:43:53.719] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:32:0)
[06:43:53.740] Build status: STARTED
[06:43:53.740] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:33:0) after 4m55s
[06:48:48.845] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:33:0)
[06:48:48.870] Build status: STARTED
[06:48:48.870] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:34:0) after 7m35s
[06:56:23.997] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:34:0)
[06:56:24.048] Build status: STARTED
[06:56:24.048] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:35:0) after 2m56s
[06:59:20.067] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:35:0)
[06:59:20.091] Build status: STARTED
[06:59:20.091] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:36:0) after 7m51s
[07:07:11.291] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:36:0)
[07:07:11.337] Build status: STARTED
[07:07:11.337] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:37:0) after 7m57s
[07:15:08.358] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:37:0)
[07:15:08.376] Build status: STARTED
[07:15:08.376] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:38:0) after 4m40s
[07:19:48.377] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:38:0)
[07:19:48.395] Build status: STARTED
[07:19:48.395] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:39:0) after 5m47s
[07:25:35.412] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:39:0)
[07:25:35.434] Build status: STARTED
[07:25:35.434] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:40:0) after 2m46s
[07:28:21.831] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:40:0)
[07:28:21.850] Build status: STARTED
[07:28:21.850] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:41:0) after 5m4s
[07:33:26.255] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:41:0)
[07:33:26.279] Build status: STARTED
[07:33:26.279] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:42:0) after 5m47s
[07:39:13.297] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:42:0)
[07:39:13.314] Build status: STARTED
[07:39:13.314] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:43:0) after 3m36s
[07:42:49.463] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:43:0)
[07:42:49.490] Build status: STARTED
[07:42:49.490] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:44:0) after 1m4s
[07:43:53.508] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:44:0)
[07:43:53.623] Build status: STARTED
[07:43:53.623] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:45:0) after 6m1s
[07:49:54.605] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:45:0)
[07:49:54.627] Build status: STARTED
[07:49:54.627] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:46:0) after 9m50s
[07:59:44.966] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:46:0)
[07:59:44.999] Build status: STARTED
[07:59:44.999] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:47:0) after 5m45s
[08:05:30.027] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:47:0)
[08:05:30.058] Build status: STARTED
[08:05:30.059] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:48:0) after 2m38s
[08:08:08.091] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:48:0)
[08:08:08.114] Build status: STARTED
[08:08:08.114] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:49:0) after 2m9s
[08:10:17.276] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:49:0)
[08:10:17.301] Build status: STARTED
[08:10:17.301] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:50:0) after 4m32s
[08:14:49.412] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:50:0)
[08:14:49.436] Build status: STARTED
[08:14:49.436] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:51:0) after 6m53s
[08:21:42.459] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:51:0)
[08:21:42.516] Build status: STARTED
[08:21:42.516] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:52:0) after 9m53s
[08:31:35.538] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:52:0)
[08:31:35.568] Build status: STARTED
[08:31:35.568] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:53:0) after 6m30s
[08:38:05.682] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:53:0)
[08:38:05.705] Build status: STARTED
[08:38:05.705] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:54:0) after 5m49s
[08:43:55.078] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:54:0)
[08:43:55.096] Build status: STARTED
[08:43:55.096] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:55:0) after 7m5s
[08:51:00.543] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:55:0)
[08:51:00.564] Build status: STARTED
[08:51:00.564] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:56:0) after 2m6s
[08:53:06.596] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:56:0)
[08:53:06.615] Build status: STARTED
[08:53:06.615] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:57:0) after 6m37s
[08:59:43.729] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:57:0)
[08:59:43.751] Build status: STARTED
[08:59:43.751] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:58:0) after 2m43s
[09:02:26.805] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:58:0)
[09:02:26.848] Build status: STARTED
[09:02:26.848] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:59:0) after 9m49s
[09:12:15.981] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:59:0)
[09:12:16.004] Build status: STARTED
[09:12:16.004] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:60:0) after 7m48s
[09:20:04.115] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:60:0)
[09:20:04.144] Build status: STARTED
[09:20:04.144] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:61:0) after 2m51s
[09:22:55.166] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:61:0)
[09:22:55.196] Build status: STARTED
[09:22:55.196] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:62:0) after 1m17s
[09:24:12.204] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:62:0)
[09:24:12.226] Build status: STARTED
[09:24:12.226] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:63:0) after 8m56s
[09:33:08.440] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:63:0)
[09:33:08.471] Build status: STARTED
[09:33:08.471] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:64:0) after 8m51s
[09:41:59.990] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:64:0)
[09:42:00.032] Build status: STARTED
[09:42:00.032] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:65:0) after 9m44s
[09:51:44.060] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:65:0)
[09:51:44.077] Build status: STARTED
[09:51:44.077] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:66:0) after 9m8s
[10:00:52.264] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:66:0)
[10:00:52.284] Build status: STARTED
[10:00:52.284] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:67:0) after 4m2s
[10:04:54.271] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:67:0)
[10:04:54.289] Build status: STARTED
[10:04:54.289] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:68:0) after 4m44s
[10:09:38.319] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:68:0)
[10:09:38.358] Build status: STARTED
[10:09:38.358] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:69:0) after 8m3s
[10:17:41.408] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:69:0)
[10:17:41.431] Build status: STARTED
[10:17:41.431] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:70:0) after 6m50s
[10:24:31.754] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:70:0)
[10:24:31.780] Build status: STARTED
[10:24:31.780] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:71:0) after 6m54s
[10:31:25.800] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:71:0)
[10:31:25.821] Build status: STARTED
[10:31:25.821] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:72:0) after 3m26s
[10:34:51.842] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:72:0)
[10:34:51.868] Build status: STARTED
[10:34:51.868] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:73:0) after 5m50s
[10:40:42.253] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:73:0)
[10:40:42.282] Build status: STARTED
[10:40:42.282] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:74:0) after 4m28s
[10:45:10.317] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:74:0)
[10:45:10.338] Build status: STARTED
[10:45:10.338] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:75:0) after 4m12s
[10:49:22.355] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:75:0)
[10:49:22.378] Build status: STARTED
[10:49:22.378] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:76:0) after 4m25s
[10:53:47.375] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:76:0)
[10:53:47.397] Build status: STARTED
[10:53:47.397] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:77:0) after 7m43s
[11:01:30.512] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:77:0)
[11:01:30.560] Build status: STARTED
[11:01:30.560] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:78:0) after 8m45s
[11:10:15.589] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:78:0)
[11:10:15.621] Build status: STARTED
[11:10:15.621] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:79:0) after 9m9s
[11:19:24.747] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:79:0)
[11:19:24.773] Build status: STARTED
[11:19:24.773] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:80:0) after 7m4s
[11:26:28.795] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:80:0)
[11:26:28.817] Build status: STARTED
[11:26:28.817] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:81:0) after 8m56s
[11:35:24.837] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:81:0)
[11:35:24.883] Build status: STARTED
[11:35:24.884] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:82:0) after 1m38s
[11:37:02.901] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:82:0)
[11:37:02.966] Build status: STARTED
[11:37:02.966] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:83:0) after 7m22s
[11:44:25.005] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:83:0)
[11:44:25.024] Build status: STARTED
[11:44:25.024] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:84:0) after 8m41s
[11:53:06.093] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:84:0)
[11:53:06.115] Build status: STARTED
[11:53:06.115] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:85:0) after 2m8s
[11:55:14.158] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:85:0)
[11:55:14.185] Build status: STARTED
[11:55:14.185] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:86:0) after 3m58s
[11:59:12.154] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:86:0)
[11:59:12.185] Build status: STARTED
[11:59:12.185] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:87:0) after 2m12s
[12:01:24.327] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:87:0)
[12:01:24.345] Build status: STARTED
[12:01:24.345] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:88:0) after 7m51s
[12:09:15.402] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:88:0)
[12:09:15.427] Build status: STARTED
[12:09:15.427] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:89:0) after 7m50s
[12:17:05.617] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:89:0)
[12:17:05.638] Build status: STARTED
[12:17:05.638] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:90:0) after 1m29s
[12:18:35.672] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:90:0)
[12:18:35.698] Build status: STARTED
[12:18:35.699] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:91:0) after 4m35s
[12:23:10.820] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:91:0)
[12:23:10.876] Build status: STARTED
[12:23:10.876] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:92:0) after 3m27s
[12:26:38.175] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:92:0)
[12:26:38.213] Build status: STARTED
[12:26:38.213] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:93:0) after 6m57s
[12:33:35.269] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:93:0)
[12:33:35.292] Build status: STARTED
[12:33:35.292] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:94:0) after 7m22s
[12:40:57.333] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:94:0)
[12:40:57.355] Build status: STARTED
[12:40:57.355] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:95:0) after 6m6s
[12:47:03.566] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:95:0)
[12:47:03.584] Build status: STARTED
[12:47:03.584] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:96:0) after 6m57s
[12:54:00.740] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:96:0)
[12:54:00.773] Build status: STARTED
[12:54:00.773] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:97:0) after 6m11s
[13:00:11.851] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:97:0)
[13:00:11.927] Build status: STARTED
[13:00:11.928] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:98:0) after 9m54s
[13:10:05.978] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:98:0)
[13:10:06.000] Build status: STARTED
[13:10:06.000] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:99:0) after 2m55s
[13:13:01.038] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:99:0)
[13:13:01.077] Build status: STARTED
[13:13:01.077] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:100:0) after 9m47s
[13:22:48.182] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:100:0)
[13:22:48.233] Build status: STARTED
[13:22:48.234] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:101:0) after 7m18s
[13:30:06.259] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:101:0)
[13:30:06.288] Build status: STARTED
[13:30:06.288] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:102:0) after 4m52s
[13:34:58.446] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:102:0)
[13:34:58.465] Build status: STARTED
[13:34:58.465] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:103:0) after 7m45s
[13:42:43.577] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:103:0)
[13:42:43.603] Build status: STARTED
[13:42:43.603] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:104:0) after 5m39s
[13:48:22.822] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:104:0)
[13:48:22.893] Build status: STARTED
[13:48:22.893] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:105:0) after 3m31s
[13:51:53.918] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:105:0)
[13:51:53.973] Build status: STARTED
[13:51:53.973] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:106:0) after 2m28s
[13:54:22.034] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:106:0)
[13:54:22.057] Build status: STARTED
[13:54:22.057] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:107:0) after 6m25s
[14:00:47.076] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:107:0)
[14:00:47.107] Build status: STARTED
[14:00:47.107] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:108:0) after 5m22s
[14:06:09.173] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:108:0)
[14:06:09.224] Build status: STARTED
[14:06:09.224] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:109:0) after 4m10s
[14:10:19.299] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:109:0)
[14:10:19.385] Build status: STARTED
[14:10:19.385] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:110:0) after 8m47s
[14:19:07.076] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:110:0)
[14:19:07.105] Build status: STARTED
[14:19:07.105] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:111:0) after 1m0s
[14:20:07.185] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:111:0)
[14:20:07.384] Build status: STARTED
[14:20:07.384] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:112:0) after 3m20s
[14:23:27.451] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:112:0)
[14:23:27.469] Build status: STARTED
[14:23:27.469] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:113:0) after 4m29s
[14:27:56.783] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:113:0)
[14:27:56.804] Build status: STARTED
[14:27:56.804] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8928644998876416400:114:0) after 2m0s
[14:28:14.041] Received PubSub notification, asking Buildbucket for the build status
[14:28:14.074] Build:
{
"id": "8763214936686462417",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-code-coverage"
},
"number": 16261,
"createdBy": "project:chromium",
"createTime": "2023-11-28T04:00:07.942742296Z",
"startTime": "2023-11-28T04:00:09.066882Z",
"endTime": "2023-11-28T14:28:13.175765Z",
"updateTime": "2023-11-28T14:28:13.175765Z",
"status": "INFRA_FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "3a4c54fe6a6f072d658ddb610c02768cf8c0fcb5",
"ref": "refs/heads/main"
}
}
}
[14:28:14.074] Invocation finished in 10h28m7.60402527s with status FAILED