[00:56:36.311] New invocation is queued and will start shortly
[00:56:37.533] Starting the invocation (attempt 1)
[00:56:37.567] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7605839342b73526f18dce899c83abaf1ebf2e68"
[00:56:37.567] Popped gitiles commit info from properties and tags
[00:56:37.567] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:56:37.567] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:56:37.567] Buildbucket request:
{
"requestId": "8931827437701250400",
"builder": {
"project": "chromium",
"bucket": "reclient",
"builder": "Windows Cross deterministic"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "7605839342b73526f18dce899c83abaf1ebf2e68",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8931827437701250400"
},
{
"key": "scheduler_job_id",
"value": "chromium/Windows Cross deterministic"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[00:56:38.145] Scheduled build:
{
"id": "8766397375650097713",
"builder": {
"project": "chromium",
"bucket": "reclient",
"builder": "Windows Cross deterministic"
},
"number": 1752,
"createdBy": "project:chromium",
"createTime": "2023-10-24T00:56:37.639616724Z",
"updateTime": "2023-10-24T00:56:37.639616724Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "7605839342b73526f18dce899c83abaf1ebf2e68",
"ref": "refs/heads/main"
}
},
"canary": true
}
[00:56:38.145] Task URL: https://cr-buildbucket.appspot.com/build/8766397375650097713
[00:56:38.145] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:2:0) after 2m10s
[00:56:39.104] Received PubSub notification, asking Buildbucket for the build status
[00:56:39.306] Build status: SCHEDULED
[00:56:45.817] Received PubSub notification, asking Buildbucket for the build status
[00:56:45.837] Build status: STARTED
[00:58:48.358] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:2:0)
[00:58:48.390] Build status: STARTED
[00:58:48.390] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:5:0) after 3m33s
[01:02:21.871] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:5:0)
[01:02:21.923] Build status: STARTED
[01:02:21.923] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:6:0) after 4m9s
[01:06:31.036] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:6:0)
[01:06:31.055] Build status: STARTED
[01:06:31.055] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:7:0) after 5m12s
[01:11:43.538] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:7:0)
[01:11:43.599] Build status: STARTED
[01:11:43.599] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:8:0) after 3m12s
[01:14:55.785] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:8:0)
[01:14:55.803] Build status: STARTED
[01:14:55.803] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:9:0) after 6m10s
[01:21:05.837] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:9:0)
[01:21:05.857] Build status: STARTED
[01:21:05.857] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:10:0) after 2m24s
[01:23:29.996] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:10:0)
[01:23:30.025] Build status: STARTED
[01:23:30.025] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:11:0) after 2m14s
[01:25:44.611] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:11:0)
[01:25:44.636] Build status: STARTED
[01:25:44.636] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:12:0) after 2m47s
[01:28:31.724] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:12:0)
[01:28:31.756] Build status: STARTED
[01:28:31.756] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:13:0) after 2m33s
[01:31:04.854] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:13:0)
[01:31:04.875] Build status: STARTED
[01:31:04.875] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:14:0) after 2m7s
[01:33:11.953] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:14:0)
[01:33:11.971] Build status: STARTED
[01:33:11.971] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:15:0) after 5m51s
[01:39:03.229] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:15:0)
[01:39:03.292] Build status: STARTED
[01:39:03.292] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:16:0) after 1m36s
[01:40:39.348] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:16:0)
[01:40:39.367] Build status: STARTED
[01:40:39.367] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:17:0) after 2m16s
[01:42:55.706] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:17:0)
[01:42:55.724] Build status: STARTED
[01:42:55.724] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:18:0) after 7m31s
[01:50:26.780] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:18:0)
[01:50:26.804] Build status: STARTED
[01:50:26.804] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:19:0) after 4m34s
[01:55:00.855] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:19:0)
[01:55:00.882] Build status: STARTED
[01:55:00.882] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:20:0) after 7m51s
[02:02:52.022] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:20:0)
[02:02:52.047] Build status: STARTED
[02:02:52.047] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:21:0) after 5m5s
[02:07:57.081] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:21:0)
[02:07:57.104] Build status: STARTED
[02:07:57.104] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:22:0) after 2m9s
[02:10:06.283] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:22:0)
[02:10:06.539] Build status: STARTED
[02:10:06.539] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:23:0) after 1m22s
[02:11:28.575] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:23:0)
[02:11:28.602] Build status: STARTED
[02:11:28.603] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:24:0) after 9m28s
[02:20:56.644] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:24:0)
[02:20:56.666] Build status: STARTED
[02:20:56.666] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:25:0) after 5m47s
[02:26:43.780] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:25:0)
[02:26:43.854] Build status: STARTED
[02:26:43.854] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:26:0) after 6m21s
[02:33:04.947] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:26:0)
[02:33:05.111] Build status: STARTED
[02:33:05.111] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:27:0) after 9m51s
[02:42:56.160] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:27:0)
[02:42:56.201] Build status: STARTED
[02:42:56.201] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:28:0) after 3m48s
[02:46:44.232] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:28:0)
[02:46:44.249] Build status: STARTED
[02:46:44.250] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:29:0) after 2m13s
[02:48:57.291] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:29:0)
[02:48:57.315] Build status: STARTED
[02:48:57.315] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:30:0) after 1m52s
[02:50:49.349] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:30:0)
[02:50:49.369] Build status: STARTED
[02:50:49.369] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:31:0) after 6m9s
[02:56:58.771] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:31:0)
[02:56:58.788] Build status: STARTED
[02:56:58.788] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:32:0) after 1m47s
[02:58:45.873] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:32:0)
[02:58:45.890] Build status: STARTED
[02:58:45.890] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:33:0) after 9m28s
[03:08:13.920] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:33:0)
[03:08:14.043] Build status: STARTED
[03:08:14.043] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:34:0) after 5m26s
[03:13:40.187] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:34:0)
[03:13:40.206] Build status: STARTED
[03:13:40.206] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:35:0) after 9m12s
[03:22:52.355] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:35:0)
[03:22:52.410] Build status: STARTED
[03:22:52.410] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:36:0) after 8m57s
[03:31:49.468] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:36:0)
[03:31:49.502] Build status: STARTED
[03:31:49.502] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:37:0) after 4m6s
[03:35:55.803] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:37:0)
[03:35:55.840] Build status: STARTED
[03:35:55.840] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:38:0) after 4m22s
[03:40:17.919] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:38:0)
[03:40:17.939] Build status: STARTED
[03:40:17.939] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:39:0) after 9m15s
[03:49:33.115] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:39:0)
[03:49:33.132] Build status: STARTED
[03:49:33.132] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:40:0) after 9m8s
[03:58:41.161] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:40:0)
[03:58:41.181] Build status: STARTED
[03:58:41.181] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:41:0) after 7m23s
[04:06:04.473] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:41:0)
[04:06:04.569] Build status: STARTED
[04:06:04.569] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:42:0) after 8m4s
[04:14:08.752] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:42:0)
[04:14:08.825] Build status: STARTED
[04:14:08.825] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:43:0) after 2m25s
[04:16:33.859] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:43:0)
[04:16:34.062] Build status: STARTED
[04:16:34.062] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:44:0) after 7m40s
[04:24:14.275] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:44:0)
[04:24:14.476] Build status: STARTED
[04:24:14.476] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:45:0) after 6m51s
[04:31:05.623] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:45:0)
[04:31:05.704] Build status: STARTED
[04:31:05.704] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:46:0) after 2m19s
[04:33:24.811] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:46:0)
[04:33:24.828] Build status: STARTED
[04:33:24.829] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:47:0) after 8m44s
[04:42:08.982] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:47:0)
[04:42:09.077] Build status: STARTED
[04:42:09.077] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:48:0) after 5m57s
[04:48:06.106] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:48:0)
[04:48:06.131] Build status: STARTED
[04:48:06.131] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:49:0) after 5m32s
[04:53:38.345] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:49:0)
[04:53:38.363] Build status: STARTED
[04:53:38.363] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:50:0) after 6m37s
[05:00:15.500] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:50:0)
[05:00:15.542] Build status: STARTED
[05:00:15.542] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:51:0) after 5m22s
[05:05:37.691] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:51:0)
[05:05:37.719] Build status: STARTED
[05:05:37.719] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:52:0) after 3m4s
[05:08:41.916] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:52:0)
[05:08:41.959] Build status: STARTED
[05:08:41.959] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:53:0) after 3m50s
[05:12:32.310] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:53:0)
[05:12:32.335] Build status: STARTED
[05:12:32.335] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:54:0) after 7m33s
[05:20:05.384] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:54:0)
[05:20:05.431] Build status: STARTED
[05:20:05.431] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:55:0) after 8m57s
[05:29:02.472] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:55:0)
[05:29:02.493] Build status: STARTED
[05:29:02.493] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:56:0) after 9m0s
[05:38:02.609] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:56:0)
[05:38:02.629] Build status: STARTED
[05:38:02.629] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:57:0) after 4m21s
[05:42:23.662] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:57:0)
[05:42:23.704] Build status: STARTED
[05:42:23.704] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:58:0) after 2m7s
[05:44:31.478] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:58:0)
[05:44:31.499] Build status: STARTED
[05:44:31.499] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:59:0) after 5m51s
[05:50:22.792] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:59:0)
[05:50:22.845] Build status: STARTED
[05:50:22.845] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:60:0) after 8m59s
[05:59:21.876] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:60:0)
[05:59:21.898] Build status: STARTED
[05:59:21.898] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:61:0) after 6m9s
[06:05:31.163] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:61:0)
[06:05:31.202] Build status: STARTED
[06:05:31.202] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:62:0) after 2m21s
[06:07:52.446] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:62:0)
[06:07:52.484] Build status: STARTED
[06:07:52.484] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:63:0) after 5m7s
[06:12:59.601] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:63:0)
[06:12:59.635] Build status: STARTED
[06:12:59.635] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:64:0) after 1m50s
[06:14:49.926] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:64:0)
[06:14:49.956] Build status: STARTED
[06:14:49.956] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:65:0) after 6m5s
[06:20:55.005] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:65:0)
[06:20:55.061] Build status: STARTED
[06:20:55.061] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:66:0) after 4m40s
[06:25:35.119] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:66:0)
[06:25:35.141] Build status: STARTED
[06:25:35.141] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:67:0) after 1m40s
[06:27:15.166] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:67:0)
[06:27:15.185] Build status: STARTED
[06:27:15.185] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:68:0) after 4m52s
[06:32:07.438] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:68:0)
[06:32:07.460] Build status: STARTED
[06:32:07.460] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:69:0) after 3m3s
[06:35:10.495] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:69:0)
[06:35:10.576] Build status: STARTED
[06:35:10.576] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:70:0) after 7m11s
[06:42:21.834] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:70:0)
[06:42:21.870] Build status: STARTED
[06:42:21.870] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:71:0) after 1m52s
[06:44:13.956] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:71:0)
[06:44:13.987] Build status: STARTED
[06:44:13.987] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:72:0) after 1m3s
[06:45:17.121] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:72:0)
[06:45:17.161] Build status: STARTED
[06:45:17.161] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:73:0) after 9m38s
[06:54:55.369] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:73:0)
[06:54:55.390] Build status: STARTED
[06:54:55.390] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:74:0) after 4m3s
[06:58:58.418] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:74:0)
[06:58:58.438] Build status: STARTED
[06:58:58.438] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:75:0) after 9m58s
[07:08:56.518] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:75:0)
[07:08:56.546] Build status: STARTED
[07:08:56.547] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:76:0) after 4m3s
[07:12:59.634] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:76:0)
[07:12:59.676] Build status: STARTED
[07:12:59.676] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:77:0) after 7m2s
[07:20:01.818] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:77:0)
[07:20:01.841] Build status: STARTED
[07:20:01.841] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:78:0) after 6m6s
[07:26:07.878] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:78:0)
[07:26:07.897] Build status: STARTED
[07:26:07.897] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:79:0) after 6m29s
[07:32:36.938] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:79:0)
[07:32:36.979] Build status: STARTED
[07:32:36.979] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:80:0) after 5m30s
[07:38:07.045] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:80:0)
[07:38:07.079] Build status: STARTED
[07:38:07.079] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:81:0) after 2m32s
[07:40:39.273] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:81:0)
[07:40:39.292] Build status: STARTED
[07:40:39.292] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:82:0) after 7m42s
[07:48:21.334] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:82:0)
[07:48:21.357] Build status: STARTED
[07:48:21.357] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:83:0) after 4m44s
[07:53:05.402] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:83:0)
[07:53:05.453] Build status: STARTED
[07:53:05.453] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:84:0) after 2m53s
[07:55:58.488] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:84:0)
[07:55:58.531] Build status: STARTED
[07:55:58.531] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:85:0) after 6m59s
[08:02:58.004] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:85:0)
[08:02:58.083] Build status: STARTED
[08:02:58.083] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:86:0) after 7m55s
[08:10:53.560] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:86:0)
[08:10:53.579] Build status: STARTED
[08:10:53.579] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:87:0) after 1m56s
[08:12:49.612] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:87:0)
[08:12:49.646] Build status: STARTED
[08:12:49.647] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:88:0) after 8m58s
[08:21:48.656] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:88:0)
[08:21:48.677] Build status: STARTED
[08:21:48.677] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:89:0) after 4m34s
[08:26:22.784] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:89:0)
[08:26:22.864] Build status: STARTED
[08:26:22.864] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:90:0) after 8m59s
[08:35:22.187] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:90:0)
[08:35:22.209] Build status: STARTED
[08:35:22.209] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:91:0) after 6m27s
[08:41:49.259] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:91:0)
[08:41:49.288] Build status: STARTED
[08:41:49.288] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:92:0) after 2m58s
[08:44:47.506] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:92:0)
[08:44:47.657] Build status: STARTED
[08:44:47.657] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:93:0) after 2m11s
[08:46:58.725] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:93:0)
[08:46:58.801] Build status: STARTED
[08:46:58.801] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:94:0) after 2m18s
[08:49:16.842] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:94:0)
[08:49:16.862] Build status: STARTED
[08:49:16.862] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:95:0) after 5m1s
[08:54:17.892] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:95:0)
[08:54:17.910] Build status: STARTED
[08:54:17.910] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:96:0) after 3m48s
[08:58:06.039] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:96:0)
[08:58:06.061] Build status: STARTED
[08:58:06.066] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:97:0) after 8m11s
[09:06:17.315] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:97:0)
[09:06:17.407] Build status: STARTED
[09:06:17.408] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:98:0) after 4m47s
[09:11:04.960] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:98:0)
[09:11:05.056] Build status: STARTED
[09:11:05.056] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:99:0) after 2m37s
[09:13:42.329] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:99:0)
[09:13:42.351] Build status: STARTED
[09:13:42.351] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:100:0) after 5m20s
[09:19:02.473] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:100:0)
[09:19:02.516] Build status: STARTED
[09:19:02.516] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:101:0) after 9m1s
[09:28:03.543] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:101:0)
[09:28:03.659] Build status: STARTED
[09:28:03.659] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:102:0) after 9m16s
[09:37:19.947] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:102:0)
[09:37:20.047] Build status: STARTED
[09:37:20.047] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:103:0) after 3m0s
[09:40:20.232] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:103:0)
[09:40:20.259] Build status: STARTED
[09:40:20.259] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:104:0) after 1m54s
[09:42:14.471] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:104:0)
[09:42:14.488] Build status: STARTED
[09:42:14.488] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:105:0) after 5m12s
[09:47:26.560] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:105:0)
[09:47:26.605] Build status: STARTED
[09:47:26.605] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:106:0) after 4m22s
[09:51:48.760] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:106:0)
[09:51:48.846] Build status: STARTED
[09:51:48.846] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:107:0) after 9m29s
[10:01:18.303] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:107:0)
[10:01:18.327] Build status: STARTED
[10:01:18.327] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:108:0) after 2m8s
[10:03:26.428] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:108:0)
[10:03:26.504] Build status: STARTED
[10:03:26.504] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:109:0) after 6m51s
[10:10:17.550] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:109:0)
[10:10:17.610] Build status: STARTED
[10:10:17.610] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:110:0) after 6m43s
[10:17:00.736] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:110:0)
[10:17:00.760] Build status: STARTED
[10:17:00.760] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:111:0) after 8m57s
[10:25:58.357] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:111:0)
[10:25:58.441] Build status: STARTED
[10:25:58.441] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:112:0) after 8m36s
[10:34:34.469] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:112:0)
[10:34:34.507] Build status: STARTED
[10:34:34.507] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:113:0) after 1m36s
[10:36:10.714] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:113:0)
[10:36:10.759] Build status: STARTED
[10:36:10.759] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:114:0) after 2m59s
[10:39:09.901] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:114:0)
[10:39:09.922] Build status: STARTED
[10:39:09.922] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:115:0) after 4m59s
[10:44:09.019] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:115:0)
[10:44:09.057] Build status: STARTED
[10:44:09.057] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:116:0) after 5m50s
[10:49:59.123] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:116:0)
[10:49:59.141] Build status: STARTED
[10:49:59.141] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:117:0) after 6m53s
[10:56:52.139] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:117:0)
[10:56:52.162] Build status: STARTED
[10:56:52.162] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:118:0) after 7m40s
[11:04:32.443] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:118:0)
[11:04:32.531] Build status: STARTED
[11:04:32.531] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:119:0) after 2m14s
[11:06:46.920] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:119:0)
[11:06:46.953] Build status: STARTED
[11:06:46.953] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:120:0) after 2m11s
[11:08:57.987] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:120:0)
[11:08:58.060] Build status: STARTED
[11:08:58.060] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:121:0) after 5m47s
[11:14:45.058] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:121:0)
[11:14:45.078] Build status: STARTED
[11:14:45.079] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:122:0) after 4m52s
[11:19:37.613] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:122:0)
[11:19:37.639] Build status: STARTED
[11:19:37.640] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:123:0) after 1m35s
[11:21:12.625] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:123:0)
[11:21:12.648] Build status: STARTED
[11:21:12.648] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:124:0) after 5m47s
[11:26:59.802] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:124:0)
[11:26:59.827] Build status: STARTED
[11:26:59.827] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:125:0) after 3m24s
[11:30:23.958] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:125:0)
[11:30:23.989] Build status: STARTED
[11:30:23.989] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:126:0) after 8m50s
[11:39:14.205] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:126:0)
[11:39:14.220] Build status: STARTED
[11:39:14.221] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:127:0) after 2m34s
[11:41:48.395] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:127:0)
[11:41:48.414] Build status: STARTED
[11:41:48.414] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:128:0) after 7m47s
[11:49:35.614] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:128:0)
[11:49:35.767] Build status: STARTED
[11:49:35.767] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:129:0) after 7m50s
[11:57:25.799] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:129:0)
[11:57:25.820] Build status: STARTED
[11:57:25.820] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:130:0) after 6m59s
[12:04:24.916] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:130:0)
[12:04:24.957] Build status: STARTED
[12:04:24.957] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:131:0) after 7m42s
[12:12:07.275] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:131:0)
[12:12:07.295] Build status: STARTED
[12:12:07.295] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:132:0) after 3m56s
[12:16:03.646] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:132:0)
[12:16:03.668] Build status: STARTED
[12:16:03.668] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:133:0) after 7m10s
[12:23:13.673] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:133:0)
[12:23:13.706] Build status: STARTED
[12:23:13.706] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:134:0) after 5m6s
[12:28:19.824] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:134:0)
[12:28:19.845] Build status: STARTED
[12:28:19.845] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:135:0) after 9m58s
[12:38:18.645] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:135:0)
[12:38:18.663] Build status: STARTED
[12:38:18.663] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:136:0) after 9m9s
[12:47:27.695] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:136:0)
[12:47:27.719] Build status: STARTED
[12:47:27.719] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:137:0) after 8m42s
[12:56:09.802] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:137:0)
[12:56:09.824] Build status: STARTED
[12:56:09.824] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:138:0) after 3m40s
[12:59:49.839] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:138:0)
[12:59:49.893] Build status: STARTED
[12:59:49.893] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:139:0) after 9m25s
[13:09:15.254] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:139:0)
[13:09:15.335] Build status: STARTED
[13:09:15.335] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:140:0) after 6m46s
[13:16:01.364] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:140:0)
[13:16:01.382] Build status: STARTED
[13:16:01.382] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8931827437701250400:141:0) after 5m50s
[13:17:06.839] Received PubSub notification, asking Buildbucket for the build status
[13:17:06.868] Build:
{
"id": "8766397375650097713",
"builder": {
"project": "chromium",
"bucket": "reclient",
"builder": "Windows Cross deterministic"
},
"number": 1752,
"createdBy": "project:chromium",
"createTime": "2023-10-24T00:56:37.639616724Z",
"startTime": "2023-10-24T00:56:39.125520Z",
"endTime": "2023-10-24T13:17:06.024159Z",
"updateTime": "2023-10-24T13:17:06.024159Z",
"status": "INFRA_FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "7605839342b73526f18dce899c83abaf1ebf2e68",
"ref": "refs/heads/main"
}
},
"canary": true
}
[13:17:06.868] Invocation finished in 12h20m30.568981174s with status FAILED