[21:38:03.237] New invocation is queued and will start shortly
[21:38:04.959] Starting the invocation (attempt 1)
[21:38:04.995] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/23b799cc85c8145d4434c7d02e13b1b33b1367c3"
[21:38:04.995] Popped gitiles commit info from properties and tags
[21:38:04.995] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:38:04.995] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:38:04.995] Buildbucket request:
{
"requestId": "8904842033480803536",
"builder": {
"project": "chromium",
"bucket": "reclient",
"builder": "Windows Cross deterministic"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "23b799cc85c8145d4434c7d02e13b1b33b1367c3",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8904842033480803536"
},
{
"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"
}
}
[21:38:07.992] Scheduled build:
{
"id": "8739411970557733569",
"builder": {
"project": "chromium",
"bucket": "reclient",
"builder": "Windows Cross deterministic"
},
"number": 2518,
"createdBy": "project:chromium",
"createTime": "2024-08-16T21:38:05.393619423Z",
"updateTime": "2024-08-16T21:38:05.393619423Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "23b799cc85c8145d4434c7d02e13b1b33b1367c3",
"ref": "refs/heads/main"
}
}
}
[21:38:07.992] Task URL: https://cr-buildbucket.appspot.com/build/8739411970557733569
[21:38:07.992] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:2:0) after 4m3s
[21:38:08.535] Received PubSub notification, asking Buildbucket for the build status
[21:38:08.578] Build status: SCHEDULED
[21:42:11.029] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:2:0)
[21:42:11.051] Build status: SCHEDULED
[21:42:11.051] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:4:0) after 9m23s
[21:51:21.502] Received PubSub notification, asking Buildbucket for the build status
[21:51:21.518] Build status: STARTED
[21:51:34.047] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:4:0)
[21:51:34.066] Build status: STARTED
[21:51:34.066] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:6:0) after 8m16s
[21:59:50.088] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:6:0)
[21:59:50.157] Build status: STARTED
[21:59:50.157] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:7:0) after 2m53s
[22:02:43.203] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:7:0)
[22:02:43.225] Build status: STARTED
[22:02:43.225] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:8:0) after 5m19s
[22:08:02.254] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:8:0)
[22:08:02.281] Build status: STARTED
[22:08:02.281] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:9:0) after 5m44s
[22:13:46.360] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:9:0)
[22:13:46.387] Build status: STARTED
[22:13:46.387] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:10:0) after 9m8s
[22:22:54.465] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:10:0)
[22:22:54.571] Build status: STARTED
[22:22:54.571] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:11:0) after 3m59s
[22:26:53.614] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:11:0)
[22:26:53.640] Build status: STARTED
[22:26:53.640] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:12:0) after 5m47s
[22:32:40.682] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:12:0)
[22:32:40.711] Build status: STARTED
[22:32:40.711] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:13:0) after 5m4s
[22:37:44.736] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:13:0)
[22:37:44.754] Build status: STARTED
[22:37:44.754] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:14:0) after 4m11s
[22:41:55.985] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:14:0)
[22:41:56.024] Build status: STARTED
[22:41:56.024] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:15:0) after 2m21s
[22:44:17.087] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:15:0)
[22:44:17.119] Build status: STARTED
[22:44:17.119] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:16:0) after 5m26s
[22:49:43.153] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:16:0)
[22:49:43.172] Build status: STARTED
[22:49:43.172] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:17:0) after 7m58s
[22:57:41.198] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:17:0)
[22:57:41.230] Build status: STARTED
[22:57:41.230] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:18:0) after 9m57s
[23:07:38.401] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:18:0)
[23:07:38.427] Build status: STARTED
[23:07:38.427] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:19:0) after 8m17s
[23:15:55.524] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:19:0)
[23:15:55.541] Build status: STARTED
[23:15:55.541] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:20:0) after 6m6s
[23:22:01.583] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:20:0)
[23:22:01.618] Build status: STARTED
[23:22:01.618] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:21:0) after 3m24s
[23:25:26.337] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:21:0)
[23:25:26.366] Build status: STARTED
[23:25:26.366] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:22:0) after 5m40s
[23:31:07.037] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:22:0)
[23:31:07.072] Build status: STARTED
[23:31:07.072] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:23:0) after 7m44s
[23:38:51.098] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:23:0)
[23:38:51.115] Build status: STARTED
[23:38:51.115] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:24:0) after 6m50s
[23:45:41.138] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:24:0)
[23:45:41.214] Build status: STARTED
[23:45:41.214] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:25:0) after 3m15s
[23:48:56.255] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:25:0)
[23:48:56.337] Build status: STARTED
[23:48:56.337] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:26:0) after 7m39s
[23:56:35.423] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:26:0)
[23:56:35.457] Build status: STARTED
[23:56:35.457] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:27:0) after 6m38s
[00:03:13.489] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:27:0)
[00:03:13.507] Build status: STARTED
[00:03:13.507] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:28:0) after 5m52s
[00:09:05.562] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:28:0)
[00:09:05.580] Build status: STARTED
[00:09:05.580] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:29:0) after 8m57s
[00:18:02.604] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:29:0)
[00:18:02.620] Build status: STARTED
[00:18:02.620] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:30:0) after 8m50s
[00:26:52.660] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:30:0)
[00:26:52.679] Build status: STARTED
[00:26:52.679] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:31:0) after 6m24s
[00:33:16.711] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:31:0)
[00:33:16.728] Build status: STARTED
[00:33:16.728] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:32:0) after 5m15s
[00:38:31.749] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:32:0)
[00:38:31.766] Build status: STARTED
[00:38:31.766] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:33:0) after 6m10s
[00:44:41.762] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:33:0)
[00:44:41.850] Build status: STARTED
[00:44:41.850] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:34:0) after 7m24s
[00:52:05.874] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:34:0)
[00:52:05.894] Build status: STARTED
[00:52:05.894] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:35:0) after 7m16s
[00:59:21.934] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:35:0)
[00:59:21.958] Build status: STARTED
[00:59:21.958] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:36:0) after 1m5s
[01:00:26.997] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:36:0)
[01:00:27.013] Build status: STARTED
[01:00:27.013] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:37:0) after 7m6s
[01:07:33.090] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:37:0)
[01:07:33.113] Build status: STARTED
[01:07:33.113] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:38:0) after 3m28s
[01:11:01.138] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:38:0)
[01:11:01.170] Build status: STARTED
[01:11:01.170] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:39:0) after 4m29s
[01:15:30.232] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:39:0)
[01:15:30.269] Build status: STARTED
[01:15:30.269] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:40:0) after 6m34s
[01:22:04.347] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:40:0)
[01:22:04.377] Build status: STARTED
[01:22:04.377] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:41:0) after 5m26s
[01:27:30.369] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:41:0)
[01:27:30.385] Build status: STARTED
[01:27:30.385] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:42:0) after 1m41s
[01:29:11.457] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:42:0)
[01:29:11.484] Build status: STARTED
[01:29:11.484] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:43:0) after 1m3s
[01:30:14.714] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:43:0)
[01:30:14.856] Build status: STARTED
[01:30:14.856] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:44:0) after 6m44s
[01:36:58.883] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:44:0)
[01:36:58.904] Build status: STARTED
[01:36:58.904] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:45:0) after 3m11s
[01:40:09.972] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:45:0)
[01:40:09.994] Build status: STARTED
[01:40:09.994] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:46:0) after 4m11s
[01:44:21.027] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:46:0)
[01:44:21.062] Build status: STARTED
[01:44:21.062] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:47:0) after 5m1s
[01:49:22.091] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:47:0)
[01:49:22.130] Build status: STARTED
[01:49:22.130] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:48:0) after 7m14s
[01:56:36.164] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:48:0)
[01:56:36.185] Build status: STARTED
[01:56:36.185] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:49:0) after 7m45s
[02:04:21.332] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:49:0)
[02:04:21.350] Build status: STARTED
[02:04:21.350] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:50:0) after 8m25s
[02:12:46.375] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:50:0)
[02:12:46.450] Build status: STARTED
[02:12:46.450] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:51:0) after 8m31s
[02:21:17.903] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:51:0)
[02:21:17.922] Build status: STARTED
[02:21:17.922] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:52:0) after 8m46s
[02:30:04.019] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:52:0)
[02:30:04.038] Build status: STARTED
[02:30:04.038] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:53:0) after 7m22s
[02:37:26.303] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:53:0)
[02:37:26.322] Build status: STARTED
[02:37:26.322] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:54:0) after 2m34s
[02:40:00.408] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:54:0)
[02:40:00.426] Build status: STARTED
[02:40:00.426] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:55:0) after 1m4s
[02:41:04.672] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:55:0)
[02:41:04.692] Build status: STARTED
[02:41:04.692] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:56:0) after 3m17s
[02:44:21.702] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:56:0)
[02:44:21.719] Build status: STARTED
[02:44:21.719] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:57:0) after 9m52s
[02:54:13.754] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:57:0)
[02:54:13.789] Build status: STARTED
[02:54:13.789] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:58:0) after 3m25s
[02:57:38.915] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:58:0)
[02:57:38.937] Build status: STARTED
[02:57:38.937] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:59:0) after 1m4s
[02:58:42.963] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:59:0)
[02:58:42.983] Build status: STARTED
[02:58:42.983] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:60:0) after 3m41s
[03:02:24.007] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:60:0)
[03:02:24.032] Build status: STARTED
[03:02:24.032] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:61:0) after 5m9s
[03:07:33.068] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:61:0)
[03:07:33.085] Build status: STARTED
[03:07:33.086] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:62:0) after 6m28s
[03:14:01.227] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:62:0)
[03:14:01.246] Build status: STARTED
[03:14:01.246] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:63:0) after 1m16s
[03:15:17.271] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:63:0)
[03:15:17.287] Build status: STARTED
[03:15:17.287] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:64:0) after 1m49s
[03:17:06.315] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:64:0)
[03:17:06.334] Build status: STARTED
[03:17:06.334] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:65:0) after 6m3s
[03:23:09.407] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:65:0)
[03:23:09.429] Build status: STARTED
[03:23:09.439] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:66:0) after 4m24s
[03:27:33.462] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:66:0)
[03:27:33.494] Build status: STARTED
[03:27:33.494] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:67:0) after 6m51s
[03:34:24.520] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:67:0)
[03:34:24.568] Build status: STARTED
[03:34:24.568] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:68:0) after 1m29s
[03:35:53.630] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:68:0)
[03:35:54.558] Build status: STARTED
[03:35:54.558] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:69:0) after 6m34s
[03:42:28.622] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:69:0)
[03:42:28.654] Build status: STARTED
[03:42:28.654] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:70:0) after 7m58s
[03:50:26.648] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:70:0)
[03:50:26.664] Build status: STARTED
[03:50:26.664] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:71:0) after 7m47s
[03:58:13.714] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:71:0)
[03:58:13.810] Build status: STARTED
[03:58:13.810] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:72:0) after 7m58s
[04:06:11.917] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:72:0)
[04:06:11.933] Build status: STARTED
[04:06:11.933] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:73:0) after 1m51s
[04:08:03.182] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:73:0)
[04:08:03.263] Build status: STARTED
[04:08:03.263] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:74:0) after 6m27s
[04:14:30.287] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:74:0)
[04:14:30.341] Build status: STARTED
[04:14:30.341] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:75:0) after 5m36s
[04:20:06.366] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:75:0)
[04:20:06.386] Build status: STARTED
[04:20:06.386] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:76:0) after 3m25s
[04:23:31.410] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:76:0)
[04:23:31.431] Build status: STARTED
[04:23:31.431] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:77:0) after 1m7s
[04:24:38.505] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:77:0)
[04:24:38.522] Build status: STARTED
[04:24:38.522] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:78:0) after 4m29s
[04:29:07.629] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:78:0)
[04:29:07.659] Build status: STARTED
[04:29:07.659] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:79:0) after 4m25s
[04:33:32.711] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:79:0)
[04:33:32.743] Build status: STARTED
[04:33:32.743] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:80:0) after 1m52s
[04:35:24.766] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:80:0)
[04:35:24.787] Build status: STARTED
[04:35:24.787] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:81:0) after 9m29s
[04:44:53.814] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:81:0)
[04:44:53.830] Build status: STARTED
[04:44:53.830] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:82:0) after 1m37s
[04:46:30.866] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:82:0)
[04:46:30.887] Build status: STARTED
[04:46:30.887] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:83:0) after 5m57s
[04:52:27.997] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:83:0)
[04:52:28.013] Build status: STARTED
[04:52:28.013] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:84:0) after 8m50s
[05:01:18.039] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:84:0)
[05:01:18.057] Build status: STARTED
[05:01:18.057] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:85:0) after 8m36s
[05:09:54.120] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:85:0)
[05:09:54.137] Build status: STARTED
[05:09:54.137] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:86:0) after 1m52s
[05:11:46.169] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:86:0)
[05:11:46.194] Build status: STARTED
[05:11:46.194] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:87:0) after 8m24s
[05:20:10.418] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:87:0)
[05:20:10.438] Build status: STARTED
[05:20:10.438] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:88:0) after 2m29s
[05:22:39.603] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:88:0)
[05:22:39.620] Build status: STARTED
[05:22:39.620] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:89:0) after 9m46s
[05:32:25.654] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:89:0)
[05:32:25.680] Build status: STARTED
[05:32:25.680] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:90:0) after 6m19s
[05:38:44.698] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:90:0)
[05:38:44.731] Build status: STARTED
[05:38:44.731] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:91:0) after 6m49s
[05:45:33.757] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:91:0)
[05:45:33.813] Build status: STARTED
[05:45:33.813] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:92:0) after 9m16s
[05:54:50.039] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:92:0)
[05:54:50.056] Build status: STARTED
[05:54:50.056] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:93:0) after 2m3s
[05:56:53.286] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:93:0)
[05:56:53.329] Build status: STARTED
[05:56:53.329] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:94:0) after 9m53s
[06:06:46.374] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:94:0)
[06:06:46.452] Build status: STARTED
[06:06:46.452] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:95:0) after 8m8s
[06:14:54.527] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:95:0)
[06:14:54.546] Build status: STARTED
[06:14:54.546] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:96:0) after 9m18s
[06:24:12.608] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:96:0)
[06:24:12.684] Build status: STARTED
[06:24:12.684] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:97:0) after 7m11s
[06:31:23.687] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:97:0)
[06:31:23.778] Build status: STARTED
[06:31:23.778] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:98:0) after 7m10s
[06:38:33.801] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:98:0)
[06:38:33.820] Build status: STARTED
[06:38:33.820] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:99:0) after 3m36s
[06:42:09.862] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:99:0)
[06:42:09.878] Build status: STARTED
[06:42:09.878] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:100:0) after 2m48s
[06:44:58.204] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:100:0)
[06:44:58.248] Build status: STARTED
[06:44:58.248] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:101:0) after 5m1s
[06:49:59.271] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:101:0)
[06:49:59.287] Build status: STARTED
[06:49:59.287] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:102:0) after 1m49s
[06:51:48.323] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:102:0)
[06:51:48.379] Build status: STARTED
[06:51:48.379] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:103:0) after 7m30s
[06:59:18.480] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:103:0)
[06:59:18.503] Build status: STARTED
[06:59:18.504] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:104:0) after 5m13s
[07:04:31.690] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:104:0)
[07:04:31.740] Build status: STARTED
[07:04:31.740] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:105:0) after 4m54s
[07:09:25.764] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:105:0)
[07:09:25.842] Build status: STARTED
[07:09:25.842] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:106:0) after 3m19s
[07:12:44.908] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:106:0)
[07:12:44.930] Build status: STARTED
[07:12:44.930] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:107:0) after 9m34s
[07:22:19.044] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:107:0)
[07:22:19.062] Build status: STARTED
[07:22:19.062] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:108:0) after 1m52s
[07:24:11.183] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:108:0)
[07:24:11.210] Build status: STARTED
[07:24:11.210] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:109:0) after 4m38s
[07:28:49.233] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:109:0)
[07:28:49.321] Build status: STARTED
[07:28:49.321] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:110:0) after 2m52s
[07:31:41.350] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:110:0)
[07:31:41.553] Build status: STARTED
[07:31:41.553] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:111:0) after 6m39s
[07:38:20.595] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:111:0)
[07:38:20.640] Build status: STARTED
[07:38:20.640] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:112:0) after 7m39s
[07:45:59.757] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:112:0)
[07:45:59.776] Build status: STARTED
[07:45:59.776] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:113:0) after 6m49s
[07:52:48.771] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:113:0)
[07:52:48.790] Build status: STARTED
[07:52:48.790] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:114:0) after 1m21s
[07:54:09.805] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:114:0)
[07:54:09.838] Build status: STARTED
[07:54:09.838] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:115:0) after 5m1s
[07:59:10.869] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:115:0)
[07:59:10.890] Build status: STARTED
[07:59:10.890] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:116:0) after 8m47s
[08:07:57.914] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:116:0)
[08:07:57.934] Build status: STARTED
[08:07:57.934] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:117:0) after 6m28s
[08:14:25.965] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:117:0)
[08:14:25.989] Build status: STARTED
[08:14:25.989] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:118:0) after 4m20s
[08:18:46.022] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:118:0)
[08:18:46.087] Build status: STARTED
[08:18:46.087] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:119:0) after 3m36s
[08:22:22.406] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:119:0)
[08:22:22.427] Build status: STARTED
[08:22:22.427] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:120:0) after 7m56s
[08:30:18.686] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:120:0)
[08:30:18.705] Build status: STARTED
[08:30:18.705] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:121:0) after 8m47s
[08:39:05.744] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:121:0)
[08:39:05.761] Build status: STARTED
[08:39:05.761] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:122:0) after 9m37s
[08:48:42.857] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:122:0)
[08:48:42.906] Build status: STARTED
[08:48:42.906] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:123:0) after 4m59s
[08:53:41.990] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:123:0)
[08:53:42.004] Build status: STARTED
[08:53:42.004] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:124:0) after 2m18s
[08:56:00.035] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:124:0)
[08:56:00.066] Build status: STARTED
[08:56:00.066] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:125:0) after 2m40s
[08:58:40.238] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:125:0)
[08:58:40.277] Build status: STARTED
[08:58:40.278] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:126:0) after 2m16s
[09:00:56.318] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:126:0)
[09:00:56.349] Build status: STARTED
[09:00:56.349] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:127:0) after 4m57s
[09:05:53.537] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:127:0)
[09:05:53.700] Build status: STARTED
[09:05:53.700] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:128:0) after 6m50s
[09:12:43.767] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:128:0)
[09:12:43.794] Build status: STARTED
[09:12:43.794] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:129:0) after 9m12s
[09:21:55.971] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:129:0)
[09:21:55.989] Build status: STARTED
[09:21:55.989] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:130:0) after 9m54s
[09:31:50.034] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:130:0)
[09:31:50.056] Build status: STARTED
[09:31:50.056] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:131:0) after 8m57s
[09:40:47.144] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:131:0)
[09:40:47.163] Build status: STARTED
[09:40:47.164] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:132:0) after 1m35s
[09:42:22.261] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:132:0)
[09:42:22.283] Build status: STARTED
[09:42:22.283] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:133:0) after 8m40s
[09:51:02.313] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:133:0)
[09:51:02.418] Build status: STARTED
[09:51:02.418] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:134:0) after 7m26s
[09:58:28.490] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:134:0)
[09:58:28.512] Build status: STARTED
[09:58:28.512] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:135:0) after 7m12s
[10:05:40.554] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:135:0)
[10:05:40.575] Build status: STARTED
[10:05:40.575] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8904842033480803536:136:0) after 5m19s
[10:07:23.908] Received PubSub notification, asking Buildbucket for the build status
[10:07:23.946] Build:
{
"id": "8739411970557733569",
"builder": {
"project": "chromium",
"bucket": "reclient",
"builder": "Windows Cross deterministic"
},
"number": 2518,
"createdBy": "project:chromium",
"createTime": "2024-08-16T21:38:05.393619423Z",
"startTime": "2024-08-16T21:51:21.291242979Z",
"endTime": "2024-08-17T10:07:09.912715023Z",
"updateTime": "2024-08-17T10:07:09.912715023Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "23b799cc85c8145d4434c7d02e13b1b33b1367c3",
"ref": "refs/heads/main"
}
}
}
[10:07:23.946] Invocation finished in 12h29m20.723833977s with status FAILED