[12:35:22.618] New invocation is queued and will start shortly
[12:35:23.687] Starting the invocation (attempt 1)
[12:35:23.719] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2b701e54e35ebd18dbdb7356df91a8fb3617c787"
[12:35:23.719] Popped gitiles commit info from properties and tags
[12:35:23.719] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:35:23.719] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:35:23.719] Buildbucket request:
{
"requestId": "8880686785731088784",
"builder": {
"project": "chromium",
"bucket": "reclient",
"builder": "Windows Cross deterministic"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "2b701e54e35ebd18dbdb7356df91a8fb3617c787",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8880686785731088784"
},
{
"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"
}
}
[12:35:24.762] Scheduled build:
{
"id": "8715256723811699025",
"builder": {
"project": "chromium",
"bucket": "reclient",
"builder": "Windows Cross deterministic"
},
"number": 3314,
"createdBy": "project:chromium",
"createTime": "2025-05-10T12:35:23.821850080Z",
"updateTime": "2025-05-10T12:35:23.821850080Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "2b701e54e35ebd18dbdb7356df91a8fb3617c787",
"ref": "refs/heads/main"
}
},
"canary": true
}
[12:35:24.762] Task URL: https://cr-buildbucket.appspot.com/build/8715256723811699025
[12:35:24.762] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:2:0) after 5m53s
[12:35:25.521] Received PubSub notification, asking Buildbucket for the build status
[12:35:25.541] Build status: SCHEDULED
[12:35:28.591] Received PubSub notification, asking Buildbucket for the build status
[12:35:28.615] Build status: STARTED
[12:41:17.786] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:2:0)
[12:41:17.810] Build status: STARTED
[12:41:17.811] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:5:0) after 1m51s
[12:43:08.916] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:5:0)
[12:43:08.979] Build status: STARTED
[12:43:08.979] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:6:0) after 8m24s
[12:51:32.997] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:6:0)
[12:51:33.040] Build status: STARTED
[12:51:33.040] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:7:0) after 4m55s
[12:56:28.059] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:7:0)
[12:56:28.074] Build status: STARTED
[12:56:28.074] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:8:0) after 9m38s
[13:06:06.273] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:8:0)
[13:06:06.293] Build status: STARTED
[13:06:06.293] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:9:0) after 7m39s
[13:13:45.314] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:9:0)
[13:13:45.347] Build status: STARTED
[13:13:45.347] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:10:0) after 1m17s
[13:15:02.441] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:10:0)
[13:15:02.457] Build status: STARTED
[13:15:02.457] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:11:0) after 8m1s
[13:23:03.488] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:11:0)
[13:23:03.504] Build status: STARTED
[13:23:03.504] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:12:0) after 8m47s
[13:31:50.570] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:12:0)
[13:31:50.602] Build status: STARTED
[13:31:50.602] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:13:0) after 5m45s
[13:37:35.781] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:13:0)
[13:37:35.822] Build status: STARTED
[13:37:35.822] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:14:0) after 8m4s
[13:45:39.862] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:14:0)
[13:45:39.882] Build status: STARTED
[13:45:39.882] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:15:0) after 3m1s
[13:48:41.009] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:15:0)
[13:48:41.028] Build status: STARTED
[13:48:41.028] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:16:0) after 6m22s
[13:55:03.109] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:16:0)
[13:55:03.136] Build status: STARTED
[13:55:03.136] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:17:0) after 5m47s
[14:00:50.238] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:17:0)
[14:00:50.312] Build status: STARTED
[14:00:50.312] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:18:0) after 4m8s
[14:04:58.382] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:18:0)
[14:04:58.399] Build status: STARTED
[14:04:58.399] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:19:0) after 4m34s
[14:09:32.426] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:19:0)
[14:09:32.444] Build status: STARTED
[14:09:32.444] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:20:0) after 1m39s
[14:11:11.461] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:20:0)
[14:11:11.495] Build status: STARTED
[14:11:11.495] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:21:0) after 2m4s
[14:13:15.591] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:21:0)
[14:13:15.619] Build status: STARTED
[14:13:15.619] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:22:0) after 8m38s
[14:21:53.752] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:22:0)
[14:21:53.789] Build status: STARTED
[14:21:53.789] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:23:0) after 3m27s
[14:25:20.856] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:23:0)
[14:25:20.873] Build status: STARTED
[14:25:20.873] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:24:0) after 7m6s
[14:32:26.891] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:24:0)
[14:32:26.917] Build status: STARTED
[14:32:26.917] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:25:0) after 8m11s
[14:40:37.937] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:25:0)
[14:40:37.955] Build status: STARTED
[14:40:37.955] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:26:0) after 3m35s
[14:44:12.973] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:26:0)
[14:44:12.993] Build status: STARTED
[14:44:12.993] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:27:0) after 5m23s
[14:49:36.200] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:27:0)
[14:49:36.231] Build status: STARTED
[14:49:36.231] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:28:0) after 9m55s
[14:59:31.297] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:28:0)
[14:59:31.319] Build status: STARTED
[14:59:31.319] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:29:0) after 6m5s
[15:05:36.345] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:29:0)
[15:05:36.363] Build status: STARTED
[15:05:36.364] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:30:0) after 2m23s
[15:07:59.373] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:30:0)
[15:07:59.391] Build status: STARTED
[15:07:59.391] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:31:0) after 9m44s
[15:17:43.740] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:31:0)
[15:17:43.759] Build status: STARTED
[15:17:43.759] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:32:0) after 5m11s
[15:22:54.887] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:32:0)
[15:22:54.913] Build status: STARTED
[15:22:54.913] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:33:0) after 3m5s
[15:25:59.909] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:33:0)
[15:25:59.930] Build status: STARTED
[15:25:59.930] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:34:0) after 7m19s
[15:33:19.195] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:34:0)
[15:33:19.329] Build status: STARTED
[15:33:19.330] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:35:0) after 9m2s
[15:42:21.460] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:35:0)
[15:42:21.482] Build status: STARTED
[15:42:21.482] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:36:0) after 3m51s
[15:46:12.653] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:36:0)
[15:46:12.683] Build status: STARTED
[15:46:12.683] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:37:0) after 2m5s
[15:48:17.661] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:37:0)
[15:48:17.700] Build status: STARTED
[15:48:17.700] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:38:0) after 1m24s
[15:49:41.719] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:38:0)
[15:49:41.740] Build status: STARTED
[15:49:41.741] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:39:0) after 7m41s
[15:57:22.768] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:39:0)
[15:57:22.785] Build status: STARTED
[15:57:22.785] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:40:0) after 7m55s
[16:05:17.802] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:40:0)
[16:05:17.830] Build status: STARTED
[16:05:17.830] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:41:0) after 7m8s
[16:12:25.859] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:41:0)
[16:12:25.902] Build status: STARTED
[16:12:25.902] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:42:0) after 1m13s
[16:13:39.006] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:42:0)
[16:13:39.036] Build status: STARTED
[16:13:39.036] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:43:0) after 6m38s
[16:20:17.068] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:43:0)
[16:20:17.089] Build status: STARTED
[16:20:17.089] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:44:0) after 7m49s
[16:28:06.118] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:44:0)
[16:28:06.146] Build status: STARTED
[16:28:06.147] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:45:0) after 1m4s
[16:29:10.196] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:45:0)
[16:29:10.241] Build status: STARTED
[16:29:10.241] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:46:0) after 5m36s
[16:34:46.453] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:46:0)
[16:34:46.479] Build status: STARTED
[16:34:46.479] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:47:0) after 8m7s
[16:42:53.602] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:47:0)
[16:42:53.621] Build status: STARTED
[16:42:53.621] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:48:0) after 1m13s
[16:44:06.911] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:48:0)
[16:44:06.931] Build status: STARTED
[16:44:06.931] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:49:0) after 1m47s
[16:45:54.010] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:49:0)
[16:45:54.028] Build status: STARTED
[16:45:54.028] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:50:0) after 5m23s
[16:51:17.053] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:50:0)
[16:51:17.081] Build status: STARTED
[16:51:17.081] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:51:0) after 2m15s
[16:53:32.104] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:51:0)
[16:53:32.123] Build status: STARTED
[16:53:32.124] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:52:0) after 5m45s
[16:59:17.101] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:52:0)
[16:59:17.119] Build status: STARTED
[16:59:17.119] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:53:0) after 5m47s
[17:05:04.146] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:53:0)
[17:05:04.176] Build status: STARTED
[17:05:04.176] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:54:0) after 2m44s
[17:07:48.195] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:54:0)
[17:07:48.214] Build status: STARTED
[17:07:48.214] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:55:0) after 3m34s
[17:11:22.535] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:55:0)
[17:11:22.556] Build status: STARTED
[17:11:22.556] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:56:0) after 2m31s
[17:13:53.585] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:56:0)
[17:13:53.616] Build status: STARTED
[17:13:53.616] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:57:0) after 8m30s
[17:22:23.606] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:57:0)
[17:22:23.684] Build status: STARTED
[17:22:23.684] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:58:0) after 8m55s
[17:31:18.738] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:58:0)
[17:31:18.759] Build status: STARTED
[17:31:18.759] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:59:0) after 6m46s
[17:38:04.856] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:59:0)
[17:38:04.876] Build status: STARTED
[17:38:04.876] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:60:0) after 8m9s
[17:46:13.900] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:60:0)
[17:46:13.921] Build status: STARTED
[17:46:13.921] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:61:0) after 9m26s
[17:55:40.147] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:61:0)
[17:55:40.223] Build status: STARTED
[17:55:40.223] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:62:0) after 9m26s
[18:05:06.232] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:62:0)
[18:05:06.266] Build status: STARTED
[18:05:06.266] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:63:0) after 2m25s
[18:07:31.309] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:63:0)
[18:07:31.339] Build status: STARTED
[18:07:31.339] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:64:0) after 2m22s
[18:09:53.362] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:64:0)
[18:09:53.383] Build status: STARTED
[18:09:53.383] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:65:0) after 6m14s
[18:16:07.363] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:65:0)
[18:16:07.382] Build status: STARTED
[18:16:07.382] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:66:0) after 5m24s
[18:21:31.587] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:66:0)
[18:21:31.626] Build status: STARTED
[18:21:31.626] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:67:0) after 1m31s
[18:23:03.098] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:67:0)
[18:23:03.120] Build status: STARTED
[18:23:03.120] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:68:0) after 3m42s
[18:26:45.142] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:68:0)
[18:26:45.215] Build status: STARTED
[18:26:45.215] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:69:0) after 1m57s
[18:28:42.455] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:69:0)
[18:28:42.569] Build status: STARTED
[18:28:42.569] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:70:0) after 1m17s
[18:29:59.714] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:70:0)
[18:29:59.758] Build status: STARTED
[18:29:59.758] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:71:0) after 5m24s
[18:35:23.763] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:71:0)
[18:35:23.783] Build status: STARTED
[18:35:23.783] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:72:0) after 9m5s
[18:44:28.783] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:72:0)
[18:44:28.847] Build status: STARTED
[18:44:28.847] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:73:0) after 9m14s
[18:53:43.197] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:73:0)
[18:53:43.215] Build status: STARTED
[18:53:43.215] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:74:0) after 2m43s
[18:56:26.507] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:74:0)
[18:56:26.588] Build status: STARTED
[18:56:26.588] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:75:0) after 7m55s
[19:04:21.671] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:75:0)
[19:04:21.700] Build status: STARTED
[19:04:21.700] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:76:0) after 5m50s
[19:10:11.669] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:76:0)
[19:10:11.687] Build status: STARTED
[19:10:11.687] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:77:0) after 4m8s
[19:14:19.729] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:77:0)
[19:14:19.749] Build status: STARTED
[19:14:19.749] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:78:0) after 2m52s
[19:17:11.863] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:78:0)
[19:17:11.882] Build status: STARTED
[19:17:11.882] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:79:0) after 3m13s
[19:20:25.125] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:79:0)
[19:20:25.152] Build status: STARTED
[19:20:25.152] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:80:0) after 7m16s
[19:27:41.204] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:80:0)
[19:27:41.237] Build status: STARTED
[19:27:41.237] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:81:0) after 1m0s
[19:28:41.305] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:81:0)
[19:28:41.322] Build status: STARTED
[19:28:41.322] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:82:0) after 6m10s
[19:34:51.355] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:82:0)
[19:34:51.390] Build status: STARTED
[19:34:51.390] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:83:0) after 2m5s
[19:36:56.415] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:83:0)
[19:36:56.431] Build status: STARTED
[19:36:56.431] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:84:0) after 1m29s
[19:38:25.632] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:84:0)
[19:38:25.647] Build status: STARTED
[19:38:25.647] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:85:0) after 8m34s
[19:46:59.667] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:85:0)
[19:46:59.687] Build status: STARTED
[19:46:59.687] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:86:0) after 1m23s
[19:48:22.972] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:86:0)
[19:48:22.993] Build status: STARTED
[19:48:22.993] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:87:0) after 3m38s
[19:52:01.014] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:87:0)
[19:52:01.060] Build status: STARTED
[19:52:01.060] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:88:0) after 9m13s
[20:01:14.040] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:88:0)
[20:01:14.067] Build status: STARTED
[20:01:14.067] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:89:0) after 1m58s
[20:03:12.139] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:89:0)
[20:03:12.215] Build status: STARTED
[20:03:12.215] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:90:0) after 5m52s
[20:09:04.247] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:90:0)
[20:09:04.270] Build status: STARTED
[20:09:04.270] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:91:0) after 8m20s
[20:17:24.278] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:91:0)
[20:17:24.303] Build status: STARTED
[20:17:24.303] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:92:0) after 4m23s
[20:21:47.337] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:92:0)
[20:21:47.364] Build status: STARTED
[20:21:47.364] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:93:0) after 9m19s
[20:31:06.514] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:93:0)
[20:31:06.555] Build status: STARTED
[20:31:06.555] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:94:0) after 6m50s
[20:37:56.636] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:94:0)
[20:37:56.669] Build status: STARTED
[20:37:56.669] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:95:0) after 4m57s
[20:42:53.695] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:95:0)
[20:42:53.721] Build status: STARTED
[20:42:53.721] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:96:0) after 9m4s
[20:51:57.829] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:96:0)
[20:51:57.890] Build status: STARTED
[20:51:57.890] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:97:0) after 3m3s
[20:55:00.913] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:97:0)
[20:55:00.944] Build status: STARTED
[20:55:00.944] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:98:0) after 7m44s
[21:02:45.139] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:98:0)
[21:02:45.162] Build status: STARTED
[21:02:45.162] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:99:0) after 5m31s
[21:08:16.275] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:99:0)
[21:08:16.293] Build status: STARTED
[21:08:16.293] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:100:0) after 1m2s
[21:09:18.358] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:100:0)
[21:09:18.392] Build status: STARTED
[21:09:18.392] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:101:0) after 5m11s
[21:14:29.418] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:101:0)
[21:14:29.441] Build status: STARTED
[21:14:29.441] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:102:0) after 3m37s
[21:18:06.518] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:102:0)
[21:18:06.539] Build status: STARTED
[21:18:06.539] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:103:0) after 6m54s
[21:25:00.618] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:103:0)
[21:25:00.641] Build status: STARTED
[21:25:00.641] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:104:0) after 8m57s
[21:33:57.673] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:104:0)
[21:33:57.767] Build status: STARTED
[21:33:57.767] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:105:0) after 9m58s
[21:43:55.826] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:105:0)
[21:43:55.844] Build status: STARTED
[21:43:55.844] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:106:0) after 2m58s
[21:46:53.871] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:106:0)
[21:46:53.892] Build status: STARTED
[21:46:53.892] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:107:0) after 7m5s
[21:53:59.199] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:107:0)
[21:53:59.230] Build status: STARTED
[21:53:59.230] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:108:0) after 6m7s
[22:00:06.352] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:108:0)
[22:00:06.371] Build status: STARTED
[22:00:06.371] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:109:0) after 3m31s
[22:03:37.416] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:109:0)
[22:03:37.445] Build status: STARTED
[22:03:37.445] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:110:0) after 3m58s
[22:07:35.700] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:110:0)
[22:07:35.718] Build status: STARTED
[22:07:35.718] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:111:0) after 1m35s
[22:09:10.916] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:111:0)
[22:09:10.937] Build status: STARTED
[22:09:10.937] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:112:0) after 2m46s
[22:11:57.037] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:112:0)
[22:11:57.058] Build status: STARTED
[22:11:57.058] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:113:0) after 9m30s
[22:21:27.087] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:113:0)
[22:21:27.193] Build status: STARTED
[22:21:27.193] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:114:0) after 6m8s
[22:27:35.240] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:114:0)
[22:27:35.276] Build status: STARTED
[22:27:35.276] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:115:0) after 1m17s
[22:28:52.271] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:115:0)
[22:28:52.288] Build status: STARTED
[22:28:52.288] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:116:0) after 7m30s
[22:36:22.462] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:116:0)
[22:36:22.478] Build status: STARTED
[22:36:22.478] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:117:0) after 9m14s
[22:45:36.498] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:117:0)
[22:45:36.578] Build status: STARTED
[22:45:36.578] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:118:0) after 5m4s
[22:50:40.730] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:118:0)
[22:50:40.753] Build status: STARTED
[22:50:40.753] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:119:0) after 6m23s
[22:57:03.855] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:119:0)
[22:57:03.870] Build status: STARTED
[22:57:03.870] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:120:0) after 8m45s
[23:05:49.071] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:120:0)
[23:05:49.115] Build status: STARTED
[23:05:49.115] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:121:0) after 6m36s
[23:12:25.244] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:121:0)
[23:12:25.289] Build status: STARTED
[23:12:25.289] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:122:0) after 8m21s
[23:20:46.320] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:122:0)
[23:20:46.339] Build status: STARTED
[23:20:46.340] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:123:0) after 1m24s
[23:22:10.417] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:123:0)
[23:22:10.434] Build status: STARTED
[23:22:10.434] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:124:0) after 3m31s
[23:25:41.795] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:124:0)
[23:25:41.810] Build status: STARTED
[23:25:41.810] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:125:0) after 8m25s
[23:34:06.824] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:125:0)
[23:34:06.844] Build status: STARTED
[23:34:06.844] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:126:0) after 7m25s
[23:41:31.866] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:126:0)
[23:41:31.936] Build status: STARTED
[23:41:31.936] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:127:0) after 9m25s
[23:50:57.251] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:127:0)
[23:50:57.266] Build status: STARTED
[23:50:57.266] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:128:0) after 8m51s
[23:59:48.292] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:128:0)
[23:59:48.311] Build status: STARTED
[23:59:48.312] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:129:0) after 2m32s
[00:02:20.336] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:129:0)
[00:02:20.354] Build status: STARTED
[00:02:20.354] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:130:0) after 4m1s
[00:06:21.383] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:130:0)
[00:06:21.398] Build status: STARTED
[00:06:21.398] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:131:0) after 5m10s
[00:11:31.473] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:131:0)
[00:11:31.495] Build status: STARTED
[00:11:31.495] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:132:0) after 9m12s
[00:20:43.521] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:132:0)
[00:20:43.586] Build status: STARTED
[00:20:43.586] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:133:0) after 9m56s
[00:30:39.615] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:133:0)
[00:30:39.632] Build status: STARTED
[00:30:39.632] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8880686785731088784:134:0) after 8m3s
[00:37:08.890] Received PubSub notification, asking Buildbucket for the build status
[00:37:08.950] Build:
{
"id": "8715256723811699025",
"builder": {
"project": "chromium",
"bucket": "reclient",
"builder": "Windows Cross deterministic"
},
"number": 3314,
"createdBy": "project:chromium",
"createTime": "2025-05-10T12:35:23.821850080Z",
"startTime": "2025-05-10T12:35:28.388181371Z",
"endTime": "2025-05-11T00:37:08.533285400Z",
"updateTime": "2025-05-11T00:37:08.533285400Z",
"status": "INFRA_FAILURE",
"statusDetails": {
"timeout": {
}
},
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "2b701e54e35ebd18dbdb7356df91a8fb3617c787",
"ref": "refs/heads/main"
}
},
"canary": true
}
[00:37:08.950] Invocation finished in 12h1m46.342805273s with status FAILED