[16:53:18.789] New invocation is queued and will start shortly
[16:53:19.973] Starting the invocation (attempt 1)
[16:53:20.002] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dd46ff6aec8f46ab52a4e95464171509c18985eb"
[16:53:20.002] Popped gitiles commit info from properties and tags
[16:53:20.002] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:53:20.002] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:53:20.002] Buildbucket request:
{
"requestId": "8928143368180914864",
"builder": {
"project": "chromium",
"bucket": "reclient",
"builder": "Windows Cross deterministic"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "dd46ff6aec8f46ab52a4e95464171509c18985eb",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8928143368180914864"
},
{
"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"
}
}
[16:53:20.622] Scheduled build:
{
"id": "8762713306184157473",
"builder": {
"project": "chromium",
"bucket": "reclient",
"builder": "Windows Cross deterministic"
},
"number": 1830,
"createdBy": "project:chromium",
"createTime": "2023-12-03T16:53:20.068255495Z",
"updateTime": "2023-12-03T16:53:20.068255495Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "dd46ff6aec8f46ab52a4e95464171509c18985eb",
"ref": "refs/heads/main"
}
}
}
[16:53:20.622] Task URL: https://cr-buildbucket.appspot.com/build/8762713306184157473
[16:53:20.623] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:2:0) after 4m36s
[16:53:20.842] Received PubSub notification, asking Buildbucket for the build status
[16:53:20.886] Build status: SCHEDULED
[16:53:22.167] Received PubSub notification, asking Buildbucket for the build status
[16:53:22.220] Build status: STARTED
[16:57:56.651] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:2:0)
[16:57:56.672] Build status: STARTED
[16:57:56.672] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:5:0) after 9m51s
[17:07:47.708] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:5:0)
[17:07:47.736] Build status: STARTED
[17:07:47.736] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:6:0) after 5m45s
[17:13:32.713] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:6:0)
[17:13:32.738] Build status: STARTED
[17:13:32.738] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:7:0) after 6m33s
[17:20:06.279] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:7:0)
[17:20:06.315] Build status: STARTED
[17:20:06.315] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:8:0) after 9m45s
[17:29:51.391] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:8:0)
[17:29:51.413] Build status: STARTED
[17:29:51.413] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:9:0) after 8m24s
[17:38:15.434] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:9:0)
[17:38:15.528] Build status: STARTED
[17:38:15.528] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:10:0) after 7m2s
[17:45:17.550] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:10:0)
[17:45:17.585] Build status: STARTED
[17:45:17.585] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:11:0) after 2m33s
[17:47:50.610] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:11:0)
[17:47:50.639] Build status: STARTED
[17:47:50.639] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:12:0) after 2m25s
[17:50:15.815] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:12:0)
[17:50:15.846] Build status: STARTED
[17:50:15.846] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:13:0) after 2m34s
[17:52:50.206] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:13:0)
[17:52:50.228] Build status: STARTED
[17:52:50.228] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:14:0) after 4m50s
[17:57:40.269] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:14:0)
[17:57:40.312] Build status: STARTED
[17:57:40.312] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:15:0) after 9m8s
[18:06:48.329] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:15:0)
[18:06:48.351] Build status: STARTED
[18:06:48.351] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:16:0) after 1m29s
[18:08:17.434] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:16:0)
[18:08:17.466] Build status: STARTED
[18:08:17.466] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:17:0) after 3m36s
[18:11:53.486] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:17:0)
[18:11:53.508] Build status: STARTED
[18:11:53.509] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:18:0) after 6m48s
[18:18:41.657] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:18:0)
[18:18:41.676] Build status: STARTED
[18:18:41.676] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:19:0) after 7m4s
[18:25:45.697] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:19:0)
[18:25:45.734] Build status: STARTED
[18:25:45.734] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:20:0) after 3m29s
[18:29:14.778] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:20:0)
[18:29:14.808] Build status: STARTED
[18:29:14.808] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:21:0) after 7m56s
[18:37:10.894] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:21:0)
[18:37:10.930] Build status: STARTED
[18:37:10.930] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:22:0) after 7m0s
[18:44:10.959] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:22:0)
[18:44:10.984] Build status: STARTED
[18:44:10.984] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:23:0) after 4m22s
[18:48:33.100] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:23:0)
[18:48:33.196] Build status: STARTED
[18:48:33.196] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:24:0) after 3m28s
[18:52:01.279] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:24:0)
[18:52:01.297] Build status: STARTED
[18:52:01.297] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:25:0) after 6m18s
[18:58:19.366] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:25:0)
[18:58:19.668] Build status: STARTED
[18:58:19.668] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:26:0) after 8m6s
[19:06:25.898] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:26:0)
[19:06:25.920] Build status: STARTED
[19:06:25.920] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:27:0) after 6m20s
[19:12:45.936] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:27:0)
[19:12:45.958] Build status: STARTED
[19:12:45.958] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:28:0) after 9m50s
[19:22:35.974] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:28:0)
[19:22:35.991] Build status: STARTED
[19:22:35.991] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:29:0) after 1m46s
[19:24:22.014] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:29:0)
[19:24:22.032] Build status: STARTED
[19:24:22.032] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:30:0) after 6m21s
[19:30:43.104] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:30:0)
[19:30:43.270] Build status: STARTED
[19:30:43.270] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:31:0) after 4m41s
[19:35:24.287] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:31:0)
[19:35:24.316] Build status: STARTED
[19:35:24.316] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:32:0) after 7m35s
[19:42:59.574] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:32:0)
[19:42:59.594] Build status: STARTED
[19:42:59.594] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:33:0) after 6m13s
[19:49:12.612] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:33:0)
[19:49:12.685] Build status: STARTED
[19:49:12.685] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:34:0) after 9m51s
[19:59:03.720] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:34:0)
[19:59:03.749] Build status: STARTED
[19:59:03.749] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:35:0) after 7m56s
[20:06:59.784] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:35:0)
[20:06:59.815] Build status: STARTED
[20:06:59.815] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:36:0) after 1m8s
[20:08:07.832] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:36:0)
[20:08:07.852] Build status: STARTED
[20:08:07.852] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:37:0) after 5m54s
[20:14:01.869] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:37:0)
[20:14:02.044] Build status: STARTED
[20:14:02.044] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:38:0) after 6m58s
[20:21:00.069] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:38:0)
[20:21:00.142] Build status: STARTED
[20:21:00.142] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:39:0) after 8m34s
[20:29:34.206] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:39:0)
[20:29:34.279] Build status: STARTED
[20:29:34.279] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:40:0) after 2m52s
[20:32:26.372] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:40:0)
[20:32:26.390] Build status: STARTED
[20:32:26.390] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:41:0) after 2m6s
[20:34:32.432] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:41:0)
[20:34:32.449] Build status: STARTED
[20:34:32.449] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:42:0) after 2m24s
[20:36:56.470] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:42:0)
[20:36:56.502] Build status: STARTED
[20:36:56.502] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:43:0) after 8m0s
[20:44:56.530] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:43:0)
[20:44:56.549] Build status: STARTED
[20:44:56.549] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:44:0) after 3m30s
[20:48:26.678] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:44:0)
[20:48:26.698] Build status: STARTED
[20:48:26.698] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:45:0) after 4m30s
[20:52:56.725] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:45:0)
[20:52:56.748] Build status: STARTED
[20:52:56.748] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:46:0) after 9m26s
[21:02:22.868] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:46:0)
[21:02:22.891] Build status: STARTED
[21:02:22.891] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:47:0) after 7m1s
[21:09:23.911] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:47:0)
[21:09:23.929] Build status: STARTED
[21:09:23.929] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:48:0) after 1m55s
[21:11:18.971] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:48:0)
[21:11:19.009] Build status: STARTED
[21:11:19.009] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:49:0) after 1m55s
[21:13:14.027] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:49:0)
[21:13:14.117] Build status: STARTED
[21:13:14.117] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:50:0) after 4m50s
[21:18:04.135] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:50:0)
[21:18:04.153] Build status: STARTED
[21:18:04.153] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:51:0) after 8m25s
[21:26:29.201] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:51:0)
[21:26:29.233] Build status: STARTED
[21:26:29.233] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:52:0) after 8m1s
[21:34:30.276] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:52:0)
[21:34:30.302] Build status: STARTED
[21:34:30.302] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:53:0) after 4m12s
[21:38:42.345] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:53:0)
[21:38:42.375] Build status: STARTED
[21:38:42.375] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:54:0) after 8m59s
[21:47:41.416] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:54:0)
[21:47:41.470] Build status: STARTED
[21:47:41.470] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:55:0) after 6m13s
[21:53:54.673] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:55:0)
[21:53:54.707] Build status: STARTED
[21:53:54.707] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:56:0) after 8m8s
[22:02:02.725] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:56:0)
[22:02:02.765] Build status: STARTED
[22:02:02.765] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:57:0) after 9m7s
[22:11:09.871] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:57:0)
[22:11:09.902] Build status: STARTED
[22:11:09.902] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:58:0) after 7m35s
[22:18:44.925] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:58:0)
[22:18:44.945] Build status: STARTED
[22:18:44.945] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:59:0) after 1m2s
[22:19:47.016] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:59:0)
[22:19:47.036] Build status: STARTED
[22:19:47.036] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:60:0) after 5m28s
[22:25:15.125] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:60:0)
[22:25:15.148] Build status: STARTED
[22:25:15.148] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:61:0) after 8m18s
[22:33:33.168] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:61:0)
[22:33:33.377] Build status: STARTED
[22:33:33.378] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:62:0) after 3m46s
[22:37:19.415] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:62:0)
[22:37:19.477] Build status: STARTED
[22:37:19.477] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:63:0) after 5m37s
[22:42:56.497] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:63:0)
[22:42:56.517] Build status: STARTED
[22:42:56.517] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:64:0) after 2m15s
[22:45:11.533] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:64:0)
[22:45:11.587] Build status: STARTED
[22:45:11.587] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:65:0) after 3m45s
[22:48:56.635] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:65:0)
[22:48:56.704] Build status: STARTED
[22:48:56.704] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:66:0) after 6m47s
[22:55:43.722] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:66:0)
[22:55:43.939] Build status: STARTED
[22:55:43.939] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:67:0) after 3m31s
[22:59:14.958] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:67:0)
[22:59:15.002] Build status: STARTED
[22:59:15.002] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:68:0) after 8m2s
[23:07:17.045] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:68:0)
[23:07:17.083] Build status: STARTED
[23:07:17.083] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:69:0) after 1m39s
[23:08:56.176] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:69:0)
[23:08:56.199] Build status: STARTED
[23:08:56.199] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:70:0) after 2m39s
[23:11:35.313] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:70:0)
[23:11:35.331] Build status: STARTED
[23:11:35.331] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:71:0) after 1m42s
[23:13:17.360] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:71:0)
[23:13:17.377] Build status: STARTED
[23:13:17.377] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:72:0) after 6m56s
[23:20:13.400] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:72:0)
[23:20:13.437] Build status: STARTED
[23:20:13.437] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:73:0) after 1m30s
[23:21:43.563] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:73:0)
[23:21:43.611] Build status: STARTED
[23:21:43.611] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:74:0) after 4m8s
[23:25:51.651] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:74:0)
[23:25:51.776] Build status: STARTED
[23:25:51.776] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:75:0) after 5m51s
[23:31:42.837] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:75:0)
[23:31:42.858] Build status: STARTED
[23:31:42.858] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:76:0) after 8m50s
[23:40:32.921] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:76:0)
[23:40:32.959] Build status: STARTED
[23:40:32.959] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:77:0) after 3m24s
[23:43:57.075] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:77:0)
[23:43:57.112] Build status: STARTED
[23:43:57.112] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:78:0) after 9m6s
[23:53:03.134] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:78:0)
[23:53:03.156] Build status: STARTED
[23:53:03.156] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:79:0) after 3m43s
[23:56:46.178] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:79:0)
[23:56:46.203] Build status: STARTED
[23:56:46.204] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:80:0) after 1m52s
[23:58:38.221] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:80:0)
[23:58:38.245] Build status: STARTED
[23:58:38.245] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:81:0) after 2m50s
[00:01:28.416] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:81:0)
[00:01:28.441] Build status: STARTED
[00:01:28.441] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:82:0) after 8m27s
[00:09:55.462] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:82:0)
[00:09:55.485] Build status: STARTED
[00:09:55.485] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:83:0) after 6m7s
[00:16:02.492] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:83:0)
[00:16:02.565] Build status: STARTED
[00:16:02.565] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:84:0) after 8m11s
[00:24:13.592] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:84:0)
[00:24:13.615] Build status: STARTED
[00:24:13.615] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:85:0) after 4m2s
[00:28:15.751] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:85:0)
[00:28:15.788] Build status: STARTED
[00:28:15.788] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:86:0) after 8m10s
[00:36:25.807] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:86:0)
[00:36:25.896] Build status: STARTED
[00:36:25.896] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:87:0) after 2m27s
[00:38:52.924] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:87:0)
[00:38:52.969] Build status: STARTED
[00:38:52.969] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:88:0) after 3m11s
[00:42:04.023] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:88:0)
[00:42:04.039] Build status: STARTED
[00:42:04.039] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:89:0) after 4m52s
[00:46:56.088] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:89:0)
[00:46:56.107] Build status: STARTED
[00:46:56.107] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:90:0) after 8m6s
[00:55:02.122] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:90:0)
[00:55:02.179] Build status: STARTED
[00:55:02.179] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:91:0) after 9m50s
[01:04:52.703] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:91:0)
[01:04:52.722] Build status: STARTED
[01:04:52.722] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:92:0) after 2m44s
[01:07:36.747] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:92:0)
[01:07:36.766] Build status: STARTED
[01:07:36.766] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:93:0) after 3m32s
[01:11:08.799] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:93:0)
[01:11:08.832] Build status: STARTED
[01:11:08.832] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:94:0) after 1m37s
[01:12:45.854] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:94:0)
[01:12:45.872] Build status: STARTED
[01:12:45.872] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:95:0) after 9m0s
[01:21:46.004] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:95:0)
[01:21:46.052] Build status: STARTED
[01:21:46.052] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:96:0) after 8m50s
[01:30:36.231] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:96:0)
[01:30:36.263] Build status: STARTED
[01:30:36.263] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:97:0) after 8m0s
[01:38:36.400] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:97:0)
[01:38:36.420] Build status: STARTED
[01:38:36.420] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:98:0) after 8m8s
[01:46:44.633] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:98:0)
[01:46:44.660] Build status: STARTED
[01:46:44.660] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:99:0) after 6m16s
[01:53:00.782] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:99:0)
[01:53:00.802] Build status: STARTED
[01:53:00.802] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:100:0) after 8m24s
[02:01:24.862] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:100:0)
[02:01:24.891] Build status: STARTED
[02:01:24.891] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:101:0) after 9m19s
[02:10:44.086] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:101:0)
[02:10:44.106] Build status: STARTED
[02:10:44.106] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:102:0) after 7m7s
[02:17:51.226] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:102:0)
[02:17:51.332] Build status: STARTED
[02:17:51.333] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:103:0) after 6m36s
[02:24:27.363] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:103:0)
[02:24:27.381] Build status: STARTED
[02:24:27.381] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:104:0) after 7m20s
[02:31:47.427] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:104:0)
[02:31:47.536] Build status: STARTED
[02:31:47.536] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:105:0) after 8m24s
[02:40:11.910] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:105:0)
[02:40:11.928] Build status: STARTED
[02:40:11.928] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:106:0) after 6m34s
[02:46:45.955] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:106:0)
[02:46:45.972] Build status: STARTED
[02:46:45.972] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:107:0) after 5m40s
[02:52:26.001] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:107:0)
[02:52:26.036] Build status: STARTED
[02:52:26.036] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:108:0) after 2m2s
[02:54:28.063] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:108:0)
[02:54:28.089] Build status: STARTED
[02:54:28.089] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:109:0) after 3m1s
[02:57:29.109] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:109:0)
[02:57:29.132] Build status: STARTED
[02:57:29.132] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:110:0) after 6m50s
[03:04:19.189] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:110:0)
[03:04:19.219] Build status: STARTED
[03:04:19.219] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:111:0) after 9m46s
[03:14:05.338] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:111:0)
[03:14:05.375] Build status: STARTED
[03:14:05.376] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:112:0) after 8m45s
[03:22:50.404] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:112:0)
[03:22:50.436] Build status: STARTED
[03:22:50.436] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:113:0) after 8m44s
[03:31:34.668] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:113:0)
[03:31:34.700] Build status: STARTED
[03:31:34.700] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:114:0) after 9m29s
[03:41:03.801] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:114:0)
[03:41:03.830] Build status: STARTED
[03:41:03.830] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:115:0) after 2m23s
[03:43:27.055] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:115:0)
[03:43:27.101] Build status: STARTED
[03:43:27.101] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:116:0) after 9m21s
[03:52:48.134] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:116:0)
[03:52:48.165] Build status: STARTED
[03:52:48.165] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:117:0) after 6m17s
[03:59:05.191] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:117:0)
[03:59:05.217] Build status: STARTED
[03:59:05.217] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:118:0) after 8m57s
[04:08:02.241] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:118:0)
[04:08:02.262] Build status: STARTED
[04:08:02.262] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:119:0) after 1m51s
[04:09:53.320] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:119:0)
[04:09:53.361] Build status: STARTED
[04:09:53.361] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:120:0) after 6m48s
[04:16:41.435] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:120:0)
[04:16:41.459] Build status: STARTED
[04:16:41.459] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:121:0) after 2m33s
[04:19:14.484] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:121:0)
[04:19:14.560] Build status: STARTED
[04:19:14.560] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:122:0) after 8m56s
[04:28:10.602] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:122:0)
[04:28:10.620] Build status: STARTED
[04:28:10.620] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:123:0) after 5m37s
[04:33:47.639] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:123:0)
[04:33:47.657] Build status: STARTED
[04:33:47.657] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:124:0) after 3m51s
[04:37:38.688] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:124:0)
[04:37:38.719] Build status: STARTED
[04:37:38.719] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:125:0) after 3m43s
[04:41:21.789] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:125:0)
[04:41:21.812] Build status: STARTED
[04:41:21.812] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:126:0) after 7m21s
[04:48:42.931] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:126:0)
[04:48:42.954] Build status: STARTED
[04:48:42.954] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:127:0) after 9m36s
[04:58:19.028] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:127:0)
[04:58:19.051] Build status: STARTED
[04:58:19.051] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:128:0) after 2m45s
[05:01:04.171] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:128:0)
[05:01:04.222] Build status: STARTED
[05:01:04.222] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:129:0) after 4m43s
[05:05:47.257] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:129:0)
[05:05:47.283] Build status: STARTED
[05:05:47.283] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:130:0) after 3m45s
[05:09:32.291] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:130:0)
[05:09:32.361] Build status: STARTED
[05:09:32.361] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:131:0) after 9m11s
[05:18:43.586] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:131:0)
[05:18:43.610] Build status: STARTED
[05:18:43.610] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8928143368180914864:132:0) after 9m23s
[05:25:16.938] Received PubSub notification, asking Buildbucket for the build status
[05:25:16.979] Build:
{
"id": "8762713306184157473",
"builder": {
"project": "chromium",
"bucket": "reclient",
"builder": "Windows Cross deterministic"
},
"number": 1830,
"createdBy": "project:chromium",
"createTime": "2023-12-03T16:53:20.068255495Z",
"startTime": "2023-12-03T16:53:21.536695Z",
"endTime": "2023-12-04T05:25:11.757443Z",
"updateTime": "2023-12-04T05:25:11.757443Z",
"status": "INFRA_FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "dd46ff6aec8f46ab52a4e95464171509c18985eb",
"ref": "refs/heads/main"
}
}
}
[05:25:16.979] Invocation finished in 12h31m58.198936621s with status FAILED