[19:30:48.276] New invocation is queued and will start shortly
[19:30:50.720] Starting the invocation (attempt 1)
[19:30:50.753] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/17dee5225cc1eab26ab71ed08a51fa2103561f2d"
[19:30:50.754] Popped gitiles commit info from properties and tags
[19:30:50.754] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:30:50.754] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:30:50.754] Buildbucket request:
{
"requestId": "8950782701289363216",
"builder": {
"project": "chromium",
"bucket": "reclient",
"builder": "Windows Cross deterministic"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "17dee5225cc1eab26ab71ed08a51fa2103561f2d",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8950782701289363216"
},
{
"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"
}
}
[19:30:51.330] Scheduled build:
{
"id": "8785352637935136001",
"builder": {
"project": "chromium",
"bucket": "reclient",
"builder": "Windows Cross deterministic"
},
"number": 1311,
"createdBy": "project:chromium",
"createTime": "2023-03-28T19:30:50.837234795Z",
"updateTime": "2023-03-28T19:30:50.837234795Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "17dee5225cc1eab26ab71ed08a51fa2103561f2d",
"ref": "refs/heads/main"
}
},
"canary": true
}
[19:30:51.330] Task URL: https://cr-buildbucket.appspot.com/build/8785352637935136001
[19:30:51.330] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:2:0) after 5m4s
[19:31:14.350] Received PubSub notification, asking Buildbucket for the build status
[19:31:14.382] Build status: STARTED
[19:35:55.468] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:2:0)
[19:35:55.642] Build status: STARTED
[19:35:55.642] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:4:0) after 9m42s
[19:45:37.747] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:4:0)
[19:45:37.775] Build status: STARTED
[19:45:37.775] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:5:0) after 7m50s
[19:53:27.803] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:5:0)
[19:53:27.824] Build status: STARTED
[19:53:27.824] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:6:0) after 3m26s
[19:56:53.810] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:6:0)
[19:56:53.988] Build status: STARTED
[19:56:53.988] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:7:0) after 3m13s
[20:00:07.307] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:7:0)
[20:00:07.371] Build status: STARTED
[20:00:07.371] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:8:0) after 4m18s
[20:04:25.398] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:8:0)
[20:04:25.421] Build status: STARTED
[20:04:25.421] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:9:0) after 1m31s
[20:05:56.451] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:9:0)
[20:05:56.517] Build status: STARTED
[20:05:56.518] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:10:0) after 8m56s
[20:14:53.389] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:10:0)
[20:14:53.419] Build status: STARTED
[20:14:53.419] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:11:0) after 9m0s
[20:23:53.472] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:11:0)
[20:23:53.494] Build status: STARTED
[20:23:53.494] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:12:0) after 6m14s
[20:30:07.757] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:12:0)
[20:30:07.790] Build status: STARTED
[20:30:07.790] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:13:0) after 1m45s
[20:31:52.828] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:13:0)
[20:31:52.926] Build status: STARTED
[20:31:52.926] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:14:0) after 8m5s
[20:39:58.200] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:14:0)
[20:39:58.277] Build status: STARTED
[20:39:58.277] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:15:0) after 4m18s
[20:44:16.464] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:15:0)
[20:44:16.501] Build status: STARTED
[20:44:16.501] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:16:0) after 1m19s
[20:45:35.815] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:16:0)
[20:45:35.839] Build status: STARTED
[20:45:35.839] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:17:0) after 2m4s
[20:47:39.913] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:17:0)
[20:47:39.951] Build status: STARTED
[20:47:39.951] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:18:0) after 9m16s
[20:56:55.982] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:18:0)
[20:56:56.077] Build status: STARTED
[20:56:56.077] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:19:0) after 5m44s
[21:02:40.108] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:19:0)
[21:02:40.130] Build status: STARTED
[21:02:40.130] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:20:0) after 3m52s
[21:06:32.179] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:20:0)
[21:06:32.391] Build status: STARTED
[21:06:32.391] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:21:0) after 5m35s
[21:12:07.430] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:21:0)
[21:12:07.461] Build status: STARTED
[21:12:07.461] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:22:0) after 3m59s
[21:16:06.497] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:22:0)
[21:16:06.527] Build status: STARTED
[21:16:06.527] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:23:0) after 9m18s
[21:25:24.565] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:23:0)
[21:25:24.622] Build status: STARTED
[21:25:24.622] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:24:0) after 9m54s
[21:35:18.965] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:24:0)
[21:35:19.003] Build status: STARTED
[21:35:19.003] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:25:0) after 1m2s
[21:36:21.035] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:25:0)
[21:36:21.076] Build status: STARTED
[21:36:21.076] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:26:0) after 3m23s
[21:39:44.252] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:26:0)
[21:39:44.274] Build status: STARTED
[21:39:44.274] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:27:0) after 3m31s
[21:43:15.399] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:27:0)
[21:43:15.425] Build status: STARTED
[21:43:15.426] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:28:0) after 2m22s
[21:45:37.665] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:28:0)
[21:45:37.687] Build status: STARTED
[21:45:37.687] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:29:0) after 3m23s
[21:49:00.984] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:29:0)
[21:49:01.024] Build status: STARTED
[21:49:01.024] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:30:0) after 3m24s
[21:52:25.067] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:30:0)
[21:52:25.104] Build status: STARTED
[21:52:25.104] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:31:0) after 3m4s
[21:55:29.353] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:31:0)
[21:55:29.377] Build status: STARTED
[21:55:29.378] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:32:0) after 2m40s
[21:58:09.395] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:32:0)
[21:58:09.424] Build status: STARTED
[21:58:09.424] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:33:0) after 9m31s
[22:07:40.460] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:33:0)
[22:07:40.498] Build status: STARTED
[22:07:40.498] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:34:0) after 1m21s
[22:09:01.585] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:34:0)
[22:09:01.609] Build status: STARTED
[22:09:01.609] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:35:0) after 6m35s
[22:15:36.704] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:35:0)
[22:15:36.727] Build status: STARTED
[22:15:36.727] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:36:0) after 4m30s
[22:20:07.301] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:36:0)
[22:20:07.323] Build status: STARTED
[22:20:07.323] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:37:0) after 2m55s
[22:23:02.373] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:37:0)
[22:23:02.399] Build status: STARTED
[22:23:02.399] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:38:0) after 8m27s
[22:31:29.655] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:38:0)
[22:31:29.679] Build status: STARTED
[22:31:29.679] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:39:0) after 4m4s
[22:35:33.954] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:39:0)
[22:35:33.992] Build status: STARTED
[22:35:33.992] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:40:0) after 3m43s
[22:41:43.612] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:40:0)
[22:41:43.637] Build status: STARTED
[22:41:43.637] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:41:0) after 5m30s
[22:47:13.667] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:41:0)
[22:47:13.696] Build status: STARTED
[22:47:13.696] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:42:0) after 4m8s
[22:51:21.985] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:42:0)
[22:51:22.008] Build status: STARTED
[22:51:22.008] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:43:0) after 6m24s
[22:57:46.573] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:43:0)
[22:57:46.607] Build status: STARTED
[22:57:46.607] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:44:0) after 7m16s
[23:05:02.829] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:44:0)
[23:05:02.858] Build status: STARTED
[23:05:02.858] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:45:0) after 5m31s
[23:10:33.884] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:45:0)
[23:10:33.909] Build status: STARTED
[23:10:33.909] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:46:0) after 9m18s
[23:19:52.004] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:46:0)
[23:19:52.027] Build status: STARTED
[23:19:52.027] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:47:0) after 4m42s
[23:24:34.509] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:47:0)
[23:24:34.537] Build status: STARTED
[23:24:34.537] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:48:0) after 7m9s
[23:31:43.683] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:48:0)
[23:31:43.705] Build status: STARTED
[23:31:43.705] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:49:0) after 4m2s
[23:35:45.783] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:49:0)
[23:35:45.807] Build status: STARTED
[23:35:45.807] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:50:0) after 5m47s
[23:41:32.799] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:50:0)
[23:41:32.820] Build status: STARTED
[23:41:32.820] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:51:0) after 6m27s
[23:47:59.929] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:51:0)
[23:47:59.951] Build status: STARTED
[23:47:59.951] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:52:0) after 3m10s
[23:51:10.624] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:52:0)
[23:51:10.662] Build status: STARTED
[23:51:10.662] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:53:0) after 6m54s
[23:58:04.725] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:53:0)
[23:58:04.761] Build status: STARTED
[23:58:04.761] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:54:0) after 1m52s
[23:59:57.087] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:54:0)
[23:59:57.125] Build status: STARTED
[23:59:57.125] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:55:0) after 1m45s
[00:01:42.166] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:55:0)
[00:01:42.199] Build status: STARTED
[00:01:42.199] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:56:0) after 7m24s
[00:09:06.271] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:56:0)
[00:09:06.306] Build status: STARTED
[00:09:06.306] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:57:0) after 9m37s
[00:18:43.431] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:57:0)
[00:18:43.459] Build status: STARTED
[00:18:43.459] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:58:0) after 7m12s
[00:25:55.486] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:58:0)
[00:25:55.527] Build status: STARTED
[00:25:55.527] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:59:0) after 1m52s
[00:27:47.554] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:59:0)
[00:27:47.589] Build status: STARTED
[00:27:47.589] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:60:0) after 8m42s
[00:36:29.887] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:60:0)
[00:36:29.909] Build status: STARTED
[00:36:29.909] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:61:0) after 6m9s
[00:42:39.035] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:61:0)
[00:42:39.063] Build status: STARTED
[00:42:39.063] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:62:0) after 3m31s
[00:46:10.367] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:62:0)
[00:46:10.444] Build status: STARTED
[00:46:10.444] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:63:0) after 5m53s
[00:52:04.097] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:63:0)
[00:52:04.137] Build status: STARTED
[00:52:04.137] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:64:0) after 2m21s
[00:54:25.316] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:64:0)
[00:54:25.339] Build status: STARTED
[00:54:25.339] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:65:0) after 6m55s
[01:01:20.459] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:65:0)
[01:01:20.549] Build status: STARTED
[01:01:20.549] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:66:0) after 8m40s
[01:10:00.916] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:66:0)
[01:10:00.940] Build status: STARTED
[01:10:00.940] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:67:0) after 1m25s
[01:11:26.014] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:67:0)
[01:11:26.040] Build status: STARTED
[01:11:26.040] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:68:0) after 7m43s
[01:19:09.199] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:68:0)
[01:19:09.228] Build status: STARTED
[01:19:09.228] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:69:0) after 1m17s
[01:20:26.343] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:69:0)
[01:20:26.369] Build status: STARTED
[01:20:26.370] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:70:0) after 9m16s
[01:29:42.395] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:70:0)
[01:29:42.417] Build status: STARTED
[01:29:42.417] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:71:0) after 3m43s
[01:33:25.695] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:71:0)
[01:33:25.723] Build status: STARTED
[01:33:25.723] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:72:0) after 4m12s
[01:37:37.749] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:72:0)
[01:37:37.770] Build status: STARTED
[01:37:37.770] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:73:0) after 1m39s
[01:39:16.901] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:73:0)
[01:39:16.936] Build status: STARTED
[01:39:16.936] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:74:0) after 3m1s
[01:42:18.267] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:74:0)
[01:42:18.291] Build status: STARTED
[01:42:18.291] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:75:0) after 1m12s
[01:43:30.321] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:75:0)
[01:43:30.351] Build status: STARTED
[01:43:30.351] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:76:0) after 9m53s
[01:53:23.478] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:76:0)
[01:53:23.502] Build status: STARTED
[01:53:23.503] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:77:0) after 6m30s
[01:59:53.532] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:77:0)
[01:59:53.561] Build status: STARTED
[01:59:53.561] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:78:0) after 5m52s
[02:05:45.692] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:78:0)
[02:05:45.715] Build status: STARTED
[02:05:45.715] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:79:0) after 7m17s
[02:13:02.997] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:79:0)
[02:13:03.029] Build status: STARTED
[02:13:03.029] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:80:0) after 1m51s
[02:14:54.101] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:80:0)
[02:14:54.127] Build status: STARTED
[02:14:54.127] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:81:0) after 1m43s
[02:16:37.156] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:81:0)
[02:16:37.194] Build status: STARTED
[02:16:37.194] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:82:0) after 9m21s
[02:25:58.481] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:82:0)
[02:25:58.508] Build status: STARTED
[02:25:58.508] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:83:0) after 2m1s
[02:27:59.566] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:83:0)
[02:27:59.589] Build status: STARTED
[02:27:59.589] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:84:0) after 5m29s
[02:33:28.625] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:84:0)
[02:33:28.683] Build status: STARTED
[02:33:28.683] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:85:0) after 7m41s
[02:41:10.222] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:85:0)
[02:41:10.250] Build status: STARTED
[02:41:10.250] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:86:0) after 7m3s
[02:48:13.437] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:86:0)
[02:48:13.465] Build status: STARTED
[02:48:13.465] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:87:0) after 7m38s
[02:55:51.575] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:87:0)
[02:55:51.804] Build status: STARTED
[02:55:51.805] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:88:0) after 6m59s
[03:02:50.836] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:88:0)
[03:02:50.858] Build status: STARTED
[03:02:50.859] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:89:0) after 7m15s
[03:10:06.097] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:89:0)
[03:10:06.160] Build status: STARTED
[03:10:06.160] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:90:0) after 3m43s
[03:13:49.273] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:90:0)
[03:13:49.300] Build status: STARTED
[03:13:49.300] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:91:0) after 4m19s
[03:18:08.368] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:91:0)
[03:18:08.391] Build status: STARTED
[03:18:08.391] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:92:0) after 7m38s
[03:25:46.416] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:92:0)
[03:25:46.436] Build status: STARTED
[03:25:46.436] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:93:0) after 4m46s
[03:30:32.678] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:93:0)
[03:30:32.704] Build status: STARTED
[03:30:32.704] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:94:0) after 4m38s
[03:35:10.731] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:94:0)
[03:35:10.784] Build status: STARTED
[03:35:10.784] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:95:0) after 7m12s
[03:42:23.028] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:95:0)
[03:42:23.052] Build status: STARTED
[03:42:23.052] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:96:0) after 9m58s
[03:52:21.137] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:96:0)
[03:52:21.158] Build status: STARTED
[03:52:21.158] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:97:0) after 1m59s
[03:54:20.172] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:97:0)
[03:54:20.228] Build status: STARTED
[03:54:20.228] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:98:0) after 7m29s
[04:01:49.723] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:98:0)
[04:01:49.758] Build status: STARTED
[04:01:49.758] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:99:0) after 3m7s
[04:04:56.843] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:99:0)
[04:04:56.903] Build status: STARTED
[04:04:56.903] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:100:0) after 2m49s
[04:07:46.062] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:100:0)
[04:07:46.100] Build status: STARTED
[04:07:46.100] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:101:0) after 6m13s
[04:13:59.533] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:101:0)
[04:13:59.556] Build status: STARTED
[04:13:59.556] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:102:0) after 9m49s
[04:23:48.695] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:102:0)
[04:23:48.720] Build status: STARTED
[04:23:48.720] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:103:0) after 6m45s
[04:30:33.882] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:103:0)
[04:30:33.906] Build status: STARTED
[04:30:33.906] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:104:0) after 5m44s
[04:36:17.985] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:104:0)
[04:36:18.018] Build status: STARTED
[04:36:18.018] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:105:0) after 6m6s
[04:42:24.123] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:105:0)
[04:42:24.148] Build status: STARTED
[04:42:24.148] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:106:0) after 6m35s
[04:48:59.372] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:106:0)
[04:48:59.406] Build status: STARTED
[04:48:59.406] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:107:0) after 7m1s
[04:56:00.491] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:107:0)
[04:56:00.515] Build status: STARTED
[04:56:00.515] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:108:0) after 7m59s
[05:03:59.735] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:108:0)
[05:03:59.757] Build status: STARTED
[05:03:59.757] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:109:0) after 4m6s
[05:08:06.005] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:109:0)
[05:08:06.039] Build status: STARTED
[05:08:06.039] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:110:0) after 7m1s
[05:15:07.093] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:110:0)
[05:15:07.189] Build status: STARTED
[05:15:07.189] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:111:0) after 9m37s
[05:24:44.402] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:111:0)
[05:24:44.445] Build status: STARTED
[05:24:44.445] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:112:0) after 9m36s
[05:34:20.474] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:112:0)
[05:34:20.501] Build status: STARTED
[05:34:20.501] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:113:0) after 7m53s
[05:42:13.636] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:113:0)
[05:42:13.661] Build status: STARTED
[05:42:13.661] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8950782701289363216:114:0) after 4m59s
[05:43:45.048] Received PubSub notification, asking Buildbucket for the build status
[05:43:45.075] Build:
{
"id": "8785352637935136001",
"builder": {
"project": "chromium",
"bucket": "reclient",
"builder": "Windows Cross deterministic"
},
"number": 1311,
"createdBy": "project:chromium",
"createTime": "2023-03-28T19:30:50.837234795Z",
"startTime": "2023-03-28T19:31:13.429764Z",
"endTime": "2023-03-29T05:43:44.721116238Z",
"updateTime": "2023-03-29T05:43:44.721116238Z",
"status": "INFRA_FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "17dee5225cc1eab26ab71ed08a51fa2103561f2d",
"ref": "refs/heads/main"
}
},
"canary": true
}
[05:43:45.075] Invocation finished in 10h12m56.820489564s with status FAILED