[04:00:06.502] New invocation is queued and will start shortly
[04:00:07.942] Starting the invocation (attempt 1)
[04:00:07.971] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9f50cb96cebe859574679726c0e07780b07fe277"
[04:00:07.972] Popped gitiles commit info from properties and tags
[04:00:07.972] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:00:07.972] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:00:07.972] Buildbucket request:
{
"requestId": "8933446638116359968",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-code-coverage"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "9f50cb96cebe859574679726c0e07780b07fe277",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8933446638116359968"
},
{
"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:09.035] Scheduled build:
{
"id": "8768016575806722241",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-code-coverage"
},
"number": 16208,
"createdBy": "project:chromium",
"createTime": "2023-10-06T04:00:08.036948053Z",
"updateTime": "2023-10-06T04:00:08.036948053Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "9f50cb96cebe859574679726c0e07780b07fe277",
"ref": "refs/heads/main"
}
}
}
[04:00:09.035] Task URL: https://cr-buildbucket.appspot.com/build/8768016575806722241
[04:00:09.035] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:2:0) after 7m17s
[04:00:09.620] Received PubSub notification, asking Buildbucket for the build status
[04:00:09.706] Build status: SCHEDULED
[04:00:12.556] Received PubSub notification, asking Buildbucket for the build status
[04:00:12.841] Build status: STARTED
[04:07:26.082] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:2:0)
[04:07:26.134] Build status: STARTED
[04:07:26.134] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:5:0) after 6m9s
[04:13:35.943] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:5:0)
[04:13:35.962] Build status: STARTED
[04:13:35.962] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:6:0) after 5m19s
[04:18:55.625] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:6:0)
[04:18:57.409] Build status: STARTED
[04:18:57.409] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:7:0) after 3m51s
[04:22:48.432] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:7:0)
[04:22:48.453] Build status: STARTED
[04:22:48.453] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:8:0) after 1m50s
[04:24:38.558] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:8:0)
[04:24:38.648] Build status: STARTED
[04:24:38.648] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:9:0) after 8m25s
[04:33:04.051] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:9:0)
[04:33:04.070] Build status: STARTED
[04:33:04.070] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:10:0) after 4m28s
[04:37:32.089] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:10:0)
[04:37:32.111] Build status: STARTED
[04:37:32.111] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:11:0) after 9m37s
[04:47:09.135] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:11:0)
[04:47:09.175] Build status: STARTED
[04:47:09.175] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:12:0) after 8m23s
[04:55:32.322] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:12:0)
[04:55:32.342] Build status: STARTED
[04:55:32.342] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:13:0) after 2m20s
[04:57:52.419] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:13:0)
[04:57:52.504] Build status: STARTED
[04:57:52.504] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:14:0) after 2m24s
[05:00:16.660] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:14:0)
[05:00:16.694] Build status: STARTED
[05:00:16.694] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:15:0) after 6m1s
[05:06:17.814] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:15:0)
[05:06:17.833] Build status: STARTED
[05:06:17.833] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:16:0) after 2m7s
[05:08:24.859] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:16:0)
[05:08:24.879] Build status: STARTED
[05:08:24.879] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:17:0) after 4m25s
[05:12:50.021] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:17:0)
[05:12:50.039] Build status: STARTED
[05:12:50.040] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:18:0) after 9m10s
[05:22:00.117] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:18:0)
[05:22:00.138] Build status: STARTED
[05:22:00.138] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:19:0) after 6m50s
[05:28:50.181] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:19:0)
[05:28:50.208] Build status: STARTED
[05:28:50.208] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:20:0) after 5m12s
[05:34:02.617] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:20:0)
[05:34:02.641] Build status: STARTED
[05:34:02.641] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:21:0) after 1m21s
[05:35:23.690] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:21:0)
[05:35:23.715] Build status: STARTED
[05:35:23.715] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:22:0) after 2m34s
[05:37:57.735] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:22:0)
[05:37:57.754] Build status: STARTED
[05:37:57.754] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:23:0) after 5m43s
[05:43:40.829] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:23:0)
[05:43:40.853] Build status: STARTED
[05:43:40.853] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:24:0) after 7m16s
[05:50:57.725] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:24:0)
[05:50:57.745] Build status: STARTED
[05:50:57.745] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:25:0) after 5m7s
[05:56:04.764] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:25:0)
[05:56:04.790] Build status: STARTED
[05:56:04.790] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:26:0) after 9m49s
[06:05:53.821] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:26:0)
[06:05:53.845] Build status: STARTED
[06:05:53.845] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:27:0) after 4m39s
[06:10:33.129] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:27:0)
[06:10:33.150] Build status: STARTED
[06:10:33.150] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:28:0) after 7m22s
[06:17:55.366] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:28:0)
[06:17:55.439] Build status: STARTED
[06:17:55.439] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:29:0) after 4m15s
[06:22:10.531] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:29:0)
[06:22:10.553] Build status: STARTED
[06:22:10.553] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:30:0) after 3m4s
[06:25:15.038] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:30:0)
[06:25:15.057] Build status: STARTED
[06:25:15.057] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:31:0) after 3m3s
[06:28:18.230] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:31:0)
[06:28:18.257] Build status: STARTED
[06:28:18.257] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:32:0) after 5m3s
[06:33:21.272] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:32:0)
[06:33:21.292] Build status: STARTED
[06:33:21.292] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:33:0) after 1m50s
[06:35:11.315] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:33:0)
[06:35:11.333] Build status: STARTED
[06:35:11.333] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:34:0) after 2m41s
[06:37:52.459] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:34:0)
[06:37:52.479] Build status: STARTED
[06:37:52.479] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:35:0) after 9m56s
[06:47:48.744] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:35:0)
[06:47:48.767] Build status: STARTED
[06:47:48.767] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:36:0) after 1m26s
[06:49:14.841] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:36:0)
[06:49:14.863] Build status: STARTED
[06:49:14.863] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:37:0) after 3m56s
[06:53:10.995] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:37:0)
[06:53:11.023] Build status: STARTED
[06:53:11.023] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:38:0) after 7m0s
[07:00:11.425] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:38:0)
[07:00:11.470] Build status: STARTED
[07:00:11.470] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:39:0) after 1m30s
[07:01:41.550] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:39:0)
[07:01:41.592] Build status: STARTED
[07:01:41.592] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:40:0) after 5m16s
[07:06:57.902] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:40:0)
[07:06:57.948] Build status: STARTED
[07:06:57.948] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:41:0) after 1m27s
[07:08:25.001] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:41:0)
[07:08:25.031] Build status: STARTED
[07:08:25.031] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:42:0) after 3m24s
[07:11:49.107] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:42:0)
[07:11:49.128] Build status: STARTED
[07:11:49.128] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:43:0) after 2m25s
[07:14:14.338] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:43:0)
[07:14:14.370] Build status: STARTED
[07:14:14.370] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:44:0) after 1m0s
[07:15:14.716] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:44:0)
[07:15:14.746] Build status: STARTED
[07:15:14.746] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:45:0) after 8m58s
[07:24:12.929] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:45:0)
[07:24:12.948] Build status: STARTED
[07:24:12.948] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:46:0) after 2m41s
[07:26:54.023] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:46:0)
[07:26:54.051] Build status: STARTED
[07:26:54.051] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:47:0) after 1m36s
[07:28:30.075] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:47:0)
[07:28:30.101] Build status: STARTED
[07:28:30.101] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:48:0) after 1m33s
[07:30:03.130] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:48:0)
[07:30:03.152] Build status: STARTED
[07:30:03.152] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:49:0) after 5m11s
[07:35:14.345] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:49:0)
[07:35:14.367] Build status: STARTED
[07:35:14.368] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:50:0) after 2m57s
[07:38:11.621] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:50:0)
[07:38:11.648] Build status: STARTED
[07:38:11.648] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:51:0) after 5m13s
[07:43:24.701] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:51:0)
[07:43:24.721] Build status: STARTED
[07:43:24.721] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:52:0) after 1m6s
[07:44:30.721] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:52:0)
[07:44:30.760] Build status: STARTED
[07:44:30.760] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:53:0) after 6m30s
[07:51:00.816] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:53:0)
[07:51:00.836] Build status: STARTED
[07:51:00.836] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:54:0) after 1m39s
[07:52:39.911] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:54:0)
[07:52:39.934] Build status: STARTED
[07:52:39.934] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:55:0) after 6m12s
[07:58:51.962] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:55:0)
[07:58:51.992] Build status: STARTED
[07:58:51.992] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:56:0) after 5m16s
[08:04:08.021] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:56:0)
[08:04:08.063] Build status: STARTED
[08:04:08.063] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:57:0) after 3m9s
[08:07:17.089] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:57:0)
[08:07:17.355] Build status: STARTED
[08:07:17.355] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:58:0) after 7m15s
[08:14:32.468] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:58:0)
[08:14:32.500] Build status: STARTED
[08:14:32.501] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:59:0) after 4m0s
[08:18:32.532] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:59:0)
[08:18:32.552] Build status: STARTED
[08:18:32.552] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:60:0) after 9m28s
[08:28:00.992] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:60:0)
[08:28:01.069] Build status: STARTED
[08:28:01.069] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:61:0) after 6m35s
[08:34:36.108] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:61:0)
[08:34:36.130] Build status: STARTED
[08:34:36.130] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:62:0) after 4m6s
[08:38:42.351] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:62:0)
[08:38:42.376] Build status: STARTED
[08:38:42.376] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:63:0) after 9m56s
[08:48:38.413] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:63:0)
[08:48:38.440] Build status: STARTED
[08:48:38.440] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:64:0) after 5m33s
[08:54:11.595] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:64:0)
[08:54:11.620] Build status: STARTED
[08:54:11.620] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:65:0) after 4m19s
[08:58:30.642] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:65:0)
[08:58:30.666] Build status: STARTED
[08:58:30.666] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:66:0) after 4m30s
[09:03:00.662] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:66:0)
[09:03:00.681] Build status: STARTED
[09:03:00.681] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:67:0) after 7m7s
[09:10:07.845] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:67:0)
[09:10:07.863] Build status: STARTED
[09:10:07.863] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:68:0) after 1m6s
[09:11:13.899] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:68:0)
[09:11:13.923] Build status: STARTED
[09:11:13.923] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:69:0) after 1m36s
[09:12:50.058] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:69:0)
[09:12:50.074] Build status: STARTED
[09:12:50.074] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:70:0) after 2m52s
[09:15:42.103] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:70:0)
[09:15:42.130] Build status: STARTED
[09:15:42.130] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:71:0) after 1m25s
[09:17:07.398] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:71:0)
[09:17:07.425] Build status: STARTED
[09:17:07.425] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:72:0) after 8m35s
[09:25:42.473] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:72:0)
[09:25:42.493] Build status: STARTED
[09:25:42.493] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:73:0) after 7m53s
[09:33:35.517] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:73:0)
[09:33:35.537] Build status: STARTED
[09:33:35.537] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:74:0) after 2m1s
[09:35:36.561] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:74:0)
[09:35:36.587] Build status: STARTED
[09:35:36.587] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:75:0) after 2m38s
[09:38:14.637] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:75:0)
[09:38:14.660] Build status: STARTED
[09:38:14.660] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:76:0) after 1m21s
[09:39:35.773] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:76:0)
[09:39:35.802] Build status: STARTED
[09:39:35.802] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:77:0) after 4m19s
[09:43:55.164] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:77:0)
[09:43:55.182] Build status: STARTED
[09:43:55.182] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:78:0) after 6m55s
[09:50:50.168] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:78:0)
[09:50:50.190] Build status: STARTED
[09:50:50.190] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:79:0) after 7m52s
[09:58:42.399] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:79:0)
[09:58:42.416] Build status: STARTED
[09:58:42.417] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:80:0) after 6m54s
[10:05:36.474] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:80:0)
[10:05:36.495] Build status: STARTED
[10:05:36.495] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:81:0) after 3m7s
[10:08:43.616] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:81:0)
[10:08:43.636] Build status: STARTED
[10:08:43.636] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:82:0) after 4m40s
[10:13:23.656] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:82:0)
[10:13:23.684] Build status: STARTED
[10:13:23.685] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:83:0) after 2m37s
[10:16:00.841] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:83:0)
[10:16:00.860] Build status: STARTED
[10:16:00.860] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:84:0) after 4m47s
[10:20:48.338] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:84:0)
[10:20:48.359] Build status: STARTED
[10:20:48.359] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:85:0) after 6m50s
[10:27:38.484] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:85:0)
[10:27:38.501] Build status: STARTED
[10:27:38.501] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:86:0) after 3m31s
[10:31:09.682] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:86:0)
[10:31:09.710] Build status: STARTED
[10:31:09.710] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:87:0) after 7m18s
[10:38:27.838] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:87:0)
[10:38:27.873] Build status: STARTED
[10:38:27.873] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:88:0) after 6m0s
[10:44:28.181] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:88:0)
[10:44:28.198] Build status: STARTED
[10:44:28.198] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:89:0) after 3m28s
[10:47:56.698] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:89:0)
[10:47:56.717] Build status: STARTED
[10:47:56.717] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:90:0) after 4m18s
[10:52:15.171] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:90:0)
[10:52:15.203] Build status: STARTED
[10:52:15.203] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:91:0) after 5m5s
[10:57:20.320] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:91:0)
[10:57:20.343] Build status: STARTED
[10:57:20.343] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:92:0) after 6m11s
[11:03:31.558] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:92:0)
[11:03:31.575] Build status: STARTED
[11:03:31.575] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:93:0) after 5m47s
[11:09:19.099] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:93:0)
[11:09:19.121] Build status: STARTED
[11:09:19.121] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:94:0) after 7m22s
[11:16:41.783] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:94:0)
[11:16:41.808] Build status: STARTED
[11:16:41.808] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:95:0) after 7m7s
[11:23:48.933] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:95:0)
[11:23:48.951] Build status: STARTED
[11:23:48.951] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:96:0) after 3m43s
[11:27:32.250] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:96:0)
[11:27:32.265] Build status: STARTED
[11:27:32.265] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:97:0) after 9m44s
[11:37:16.556] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:97:0)
[11:37:16.624] Build status: STARTED
[11:37:16.624] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:98:0) after 2m58s
[11:40:14.836] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:98:0)
[11:40:14.980] Build status: STARTED
[11:40:14.980] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:99:0) after 6m49s
[11:47:04.010] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:99:0)
[11:47:04.042] Build status: STARTED
[11:47:04.042] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:100:0) after 7m34s
[11:54:38.193] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:100:0)
[11:54:38.245] Build status: STARTED
[11:54:38.245] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:101:0) after 4m51s
[11:59:29.273] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:101:0)
[11:59:29.292] Build status: STARTED
[11:59:29.292] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:102:0) after 6m56s
[12:06:25.409] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:102:0)
[12:06:25.458] Build status: STARTED
[12:06:25.458] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:103:0) after 6m37s
[12:13:02.484] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:103:0)
[12:13:02.542] Build status: STARTED
[12:13:02.542] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:104:0) after 9m55s
[12:22:57.561] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:104:0)
[12:22:57.577] Build status: STARTED
[12:22:57.577] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:105:0) after 7m1s
[12:29:58.723] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:105:0)
[12:29:58.757] Build status: STARTED
[12:29:58.757] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:106:0) after 8m54s
[12:38:52.880] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:106:0)
[12:38:52.898] Build status: STARTED
[12:38:52.898] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:107:0) after 6m48s
[12:45:41.044] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:107:0)
[12:45:41.082] Build status: STARTED
[12:45:41.082] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:108:0) after 8m10s
[12:53:51.265] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:108:0)
[12:53:51.283] Build status: STARTED
[12:53:51.283] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:109:0) after 5m46s
[12:59:37.833] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:109:0)
[12:59:37.903] Build status: STARTED
[12:59:37.903] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:110:0) after 3m4s
[13:02:41.998] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:110:0)
[13:02:42.122] Build status: STARTED
[13:02:42.122] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:111:0) after 9m44s
[13:12:26.155] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:111:0)
[13:12:26.181] Build status: STARTED
[13:12:26.182] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:112:0) after 3m44s
[13:16:10.215] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:112:0)
[13:16:10.236] Build status: STARTED
[13:16:10.236] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:113:0) after 8m37s
[13:24:47.347] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:113:0)
[13:24:47.368] Build status: STARTED
[13:24:47.368] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:114:0) after 1m16s
[13:26:03.387] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:114:0)
[13:26:03.409] Build status: STARTED
[13:26:03.410] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:115:0) after 6m38s
[13:32:41.612] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:115:0)
[13:32:41.629] Build status: STARTED
[13:32:41.629] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:116:0) after 5m19s
[13:38:01.199] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:116:0)
[13:38:01.282] Build status: STARTED
[13:38:01.282] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:117:0) after 4m37s
[13:42:38.531] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:117:0)
[13:42:38.553] Build status: STARTED
[13:42:38.553] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:118:0) after 4m31s
[13:47:09.794] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:118:0)
[13:47:09.885] Build status: STARTED
[13:47:09.885] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:119:0) after 8m29s
[13:55:38.918] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:119:0)
[13:55:39.089] Build status: STARTED
[13:55:39.089] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:120:0) after 2m37s
[13:58:16.207] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:120:0)
[13:58:16.226] Build status: STARTED
[13:58:16.226] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:121:0) after 4m30s
[14:02:46.257] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:121:0)
[14:02:46.278] Build status: STARTED
[14:02:46.278] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:122:0) after 2m49s
[14:05:35.468] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:122:0)
[14:05:35.515] Build status: STARTED
[14:05:35.515] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:123:0) after 1m33s
[14:07:08.540] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:123:0)
[14:07:08.590] Build status: STARTED
[14:07:08.590] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:124:0) after 1m57s
[14:09:05.617] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:124:0)
[14:09:05.643] Build status: STARTED
[14:09:05.643] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:125:0) after 5m8s
[14:14:13.680] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:125:0)
[14:14:13.760] Build status: STARTED
[14:14:13.760] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:126:0) after 2m43s
[14:16:57.016] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:126:0)
[14:16:57.039] Build status: STARTED
[14:16:57.039] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:127:0) after 1m54s
[14:18:51.111] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:127:0)
[14:18:51.207] Build status: STARTED
[14:18:51.207] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:128:0) after 2m1s
[14:20:52.210] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:128:0)
[14:20:52.228] Build status: STARTED
[14:20:52.228] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:129:0) after 8m30s
[14:29:22.597] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:129:0)
[14:29:22.614] Build status: STARTED
[14:29:22.614] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:130:0) after 7m44s
[14:37:06.592] Handling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:130:0)
[14:37:06.611] Build status: STARTED
[14:37:06.612] Scheduling timer "check-buildbucket-build-status" (chromium/win10-code-coverage:8933446638116359968:131:0) after 5m30s
[14:41:26.367] Received PubSub notification, asking Buildbucket for the build status
[14:41:26.410] Build:
{
"id": "8768016575806722241",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win10-code-coverage"
},
"number": 16208,
"createdBy": "project:chromium",
"createTime": "2023-10-06T04:00:08.036948053Z",
"startTime": "2023-10-06T04:00:11.488759Z",
"endTime": "2023-10-06T14:41:25.759317534Z",
"updateTime": "2023-10-06T14:41:25.759317534Z",
"status": "INFRA_FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "9f50cb96cebe859574679726c0e07780b07fe277",
"ref": "refs/heads/main"
}
}
}
[14:41:26.410] Invocation finished in 10h41m19.960372261s with status FAILED