[20:53:23.420] New invocation is queued and will start shortly
[20:53:24.574] Starting the invocation (attempt 1)
[20:53:24.610] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/41c9c4ccb29242e349ea2962b696cfbf0d2fdc3c"
[20:53:24.610] Popped gitiles commit info from properties and tags
[20:53:24.610] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:53:24.610] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:53:24.610] Buildbucket request:
{
"requestId": "8924504385184184608",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Comparison Windows (8 cores) (reclient)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "41c9c4ccb29242e349ea2962b696cfbf0d2fdc3c",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8924504385184184608"
},
{
"key": "scheduler_job_id",
"value": "chromium/Comparison Windows (8 cores) (reclient)"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[20:53:25.280] Scheduled build:
{
"id": "8759074323193784577",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Comparison Windows (8 cores) (reclient)"
},
"number": 2956,
"createdBy": "project:chromium",
"createTime": "2024-01-12T20:53:24.684438228Z",
"updateTime": "2024-01-12T20:53:24.684438228Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "41c9c4ccb29242e349ea2962b696cfbf0d2fdc3c",
"ref": "refs/heads/main"
}
}
}
[20:53:25.280] Task URL: https://cr-buildbucket.appspot.com/build/8759074323193784577
[20:53:25.280] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:2:0) after 8m25s
[20:53:26.089] Received PubSub notification, asking Buildbucket for the build status
[20:53:26.109] Build status: SCHEDULED
[20:53:26.401] Received PubSub notification, asking Buildbucket for the build status
[20:53:26.418] Build status: STARTED
[21:01:50.376] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:2:0)
[21:01:50.400] Build status: STARTED
[21:01:50.400] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:5:0) after 4m2s
[21:05:52.437] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:5:0)
[21:05:52.455] Build status: STARTED
[21:05:52.456] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:6:0) after 9m5s
[21:14:57.548] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:6:0)
[21:14:57.574] Build status: STARTED
[21:14:57.574] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:7:0) after 2m9s
[21:17:06.651] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:7:0)
[21:17:06.678] Build status: STARTED
[21:17:06.678] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:8:0) after 3m42s
[21:20:48.778] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:8:0)
[21:20:48.801] Build status: STARTED
[21:20:48.801] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:9:0) after 7m34s
[21:28:22.888] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:9:0)
[21:28:22.907] Build status: STARTED
[21:28:22.907] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:10:0) after 5m45s
[21:34:07.953] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:10:0)
[21:34:07.976] Build status: STARTED
[21:34:07.976] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:11:0) after 2m37s
[21:36:45.024] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:11:0)
[21:36:45.050] Build status: STARTED
[21:36:45.050] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:12:0) after 9m8s
[21:45:53.093] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:12:0)
[21:45:53.114] Build status: STARTED
[21:45:53.114] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:13:0) after 8m54s
[21:54:47.205] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:13:0)
[21:54:47.226] Build status: STARTED
[21:54:47.226] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:14:0) after 9m7s
[22:03:54.294] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:14:0)
[22:03:54.328] Build status: STARTED
[22:03:54.328] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:15:0) after 8m2s
[22:11:56.393] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:15:0)
[22:11:56.488] Build status: STARTED
[22:11:56.488] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:16:0) after 5m13s
[22:17:09.806] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:16:0)
[22:17:09.826] Build status: STARTED
[22:17:09.826] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:17:0) after 5m8s
[22:22:17.861] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:17:0)
[22:22:17.881] Build status: STARTED
[22:22:17.881] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:18:0) after 2m2s
[22:24:19.901] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:18:0)
[22:24:19.917] Build status: STARTED
[22:24:19.917] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:19:0) after 3m42s
[22:28:02.067] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:19:0)
[22:28:02.134] Build status: STARTED
[22:28:02.134] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:20:0) after 1m5s
[22:29:07.163] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:20:0)
[22:29:07.229] Build status: STARTED
[22:29:07.230] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:21:0) after 4m4s
[22:33:11.369] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:21:0)
[22:33:11.404] Build status: STARTED
[22:33:11.404] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:22:0) after 9m57s
[22:43:08.852] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:22:0)
[22:43:08.871] Build status: STARTED
[22:43:08.871] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:23:0) after 6m13s
[22:49:22.040] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:23:0)
[22:49:22.058] Build status: STARTED
[22:49:22.058] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:24:0) after 9m15s
[22:58:37.097] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:24:0)
[22:58:37.245] Build status: STARTED
[22:58:37.245] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:25:0) after 8m31s
[23:07:08.274] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:25:0)
[23:07:08.336] Build status: STARTED
[23:07:08.336] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:26:0) after 1m1s
[23:08:09.358] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:26:0)
[23:08:09.375] Build status: STARTED
[23:08:09.375] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:27:0) after 3m48s
[23:11:57.678] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:27:0)
[23:11:57.693] Build status: STARTED
[23:11:57.693] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:28:0) after 7m35s
[23:19:32.813] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:28:0)
[23:19:32.835] Build status: STARTED
[23:19:32.835] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:29:0) after 9m48s
[23:29:21.370] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:29:0)
[23:29:21.384] Build status: STARTED
[23:29:21.384] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:30:0) after 4m6s
[23:33:27.465] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:30:0)
[23:33:27.488] Build status: STARTED
[23:33:27.488] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:31:0) after 7m24s
[23:40:51.750] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:31:0)
[23:40:51.768] Build status: STARTED
[23:40:51.768] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:32:0) after 3m21s
[23:44:13.167] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:32:0)
[23:44:13.187] Build status: STARTED
[23:44:13.187] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:33:0) after 5m42s
[23:49:55.685] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:33:0)
[23:49:55.703] Build status: STARTED
[23:49:55.703] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:34:0) after 4m52s
[23:54:47.729] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:34:0)
[23:54:47.745] Build status: STARTED
[23:54:47.745] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:35:0) after 6m50s
[00:01:37.764] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:35:0)
[00:01:37.783] Build status: STARTED
[00:01:37.783] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:36:0) after 1m16s
[00:02:53.860] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:36:0)
[00:02:53.885] Build status: STARTED
[00:02:53.885] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:37:0) after 3m30s
[00:06:23.920] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:37:0)
[00:06:24.040] Build status: STARTED
[00:06:24.041] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:38:0) after 4m11s
[00:10:35.156] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:38:0)
[00:10:35.174] Build status: STARTED
[00:10:35.175] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:39:0) after 1m10s
[00:11:45.248] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:39:0)
[00:11:45.269] Build status: STARTED
[00:11:45.269] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:40:0) after 1m1s
[00:12:46.310] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:40:0)
[00:12:46.332] Build status: STARTED
[00:12:46.332] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:41:0) after 5m39s
[00:18:25.413] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:41:0)
[00:18:25.455] Build status: STARTED
[00:18:25.455] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:42:0) after 2m4s
[00:20:29.538] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:42:0)
[00:20:29.638] Build status: STARTED
[00:20:29.638] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:43:0) after 2m57s
[00:23:26.657] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:43:0)
[00:23:26.684] Build status: STARTED
[00:23:26.684] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:44:0) after 3m2s
[00:26:28.854] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:44:0)
[00:26:28.873] Build status: STARTED
[00:26:28.873] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:45:0) after 9m54s
[00:36:23.105] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:45:0)
[00:36:23.125] Build status: STARTED
[00:36:23.125] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:46:0) after 9m42s
[00:46:05.152] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:46:0)
[00:46:05.170] Build status: STARTED
[00:46:05.170] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:47:0) after 9m0s
[00:55:05.210] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:47:0)
[00:55:05.230] Build status: STARTED
[00:55:05.230] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:48:0) after 7m31s
[01:02:36.255] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:48:0)
[01:02:36.271] Build status: STARTED
[01:02:36.271] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:49:0) after 7m40s
[01:10:16.306] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:49:0)
[01:10:16.324] Build status: STARTED
[01:10:16.324] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:50:0) after 7m58s
[01:18:14.367] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:50:0)
[01:18:14.384] Build status: STARTED
[01:18:14.384] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:51:0) after 6m3s
[01:24:17.426] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:51:0)
[01:24:17.444] Build status: STARTED
[01:24:17.444] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:52:0) after 2m30s
[01:26:47.473] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:52:0)
[01:26:47.489] Build status: STARTED
[01:26:47.489] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:53:0) after 1m34s
[01:28:21.524] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:53:0)
[01:28:21.545] Build status: STARTED
[01:28:21.545] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:54:0) after 6m5s
[01:34:26.637] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:54:0)
[01:34:26.657] Build status: STARTED
[01:34:26.657] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:55:0) after 5m24s
[01:39:50.708] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:55:0)
[01:39:50.727] Build status: STARTED
[01:39:50.727] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:56:0) after 8m43s
[01:48:33.760] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:56:0)
[01:48:33.818] Build status: STARTED
[01:48:33.818] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:57:0) after 9m52s
[01:58:25.848] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:57:0)
[01:58:25.867] Build status: STARTED
[01:58:25.867] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:58:0) after 3m32s
[02:01:58.438] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:58:0)
[02:01:58.468] Build status: STARTED
[02:01:58.468] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:59:0) after 2m30s
[02:04:29.066] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:59:0)
[02:04:29.087] Build status: STARTED
[02:04:29.087] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:60:0) after 4m19s
[02:08:48.121] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:60:0)
[02:08:48.147] Build status: STARTED
[02:08:48.147] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:61:0) after 2m28s
[02:11:16.177] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:61:0)
[02:11:16.201] Build status: STARTED
[02:11:16.201] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:62:0) after 2m56s
[02:14:12.238] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:62:0)
[02:14:12.256] Build status: STARTED
[02:14:12.256] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:63:0) after 4m41s
[02:18:53.355] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:63:0)
[02:18:53.377] Build status: STARTED
[02:18:53.377] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:64:0) after 7m53s
[02:26:46.502] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:64:0)
[02:26:46.529] Build status: STARTED
[02:26:46.529] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:65:0) after 2m36s
[02:29:22.673] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:65:0)
[02:29:22.691] Build status: STARTED
[02:29:22.691] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:66:0) after 7m59s
[02:37:21.867] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:66:0)
[02:37:21.883] Build status: STARTED
[02:37:21.883] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:67:0) after 3m26s
[02:40:48.213] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:67:0)
[02:40:48.233] Build status: STARTED
[02:40:48.233] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:68:0) after 5m50s
[02:46:38.286] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:68:0)
[02:46:38.303] Build status: STARTED
[02:46:38.303] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:69:0) after 9m56s
[02:56:34.636] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:69:0)
[02:56:34.655] Build status: STARTED
[02:56:34.655] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:70:0) after 6m33s
[03:03:07.692] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:70:0)
[03:03:07.718] Build status: STARTED
[03:03:07.718] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:71:0) after 6m51s
[03:09:58.859] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:71:0)
[03:09:58.883] Build status: STARTED
[03:09:58.884] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:72:0) after 8m42s
[03:18:41.281] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:72:0)
[03:18:41.297] Build status: STARTED
[03:18:41.298] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:73:0) after 2m5s
[03:20:46.403] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:73:0)
[03:20:46.473] Build status: STARTED
[03:20:46.473] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:74:0) after 2m56s
[03:23:42.701] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:74:0)
[03:23:42.725] Build status: STARTED
[03:23:42.725] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:75:0) after 1m41s
[03:25:23.962] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:75:0)
[03:25:23.985] Build status: STARTED
[03:25:23.985] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:76:0) after 7m25s
[03:32:49.178] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:76:0)
[03:32:49.274] Build status: STARTED
[03:32:49.274] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:77:0) after 7m24s
[03:40:13.395] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:77:0)
[03:40:13.504] Build status: STARTED
[03:40:13.504] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:78:0) after 1m57s
[03:42:10.608] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:78:0)
[03:42:10.657] Build status: STARTED
[03:42:10.657] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:79:0) after 4m12s
[03:46:23.035] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:79:0)
[03:46:23.109] Build status: STARTED
[03:46:23.109] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:80:0) after 8m22s
[03:54:45.222] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:80:0)
[03:54:45.245] Build status: STARTED
[03:54:45.245] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:81:0) after 9m37s
[04:04:22.305] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:81:0)
[04:04:22.330] Build status: STARTED
[04:04:22.330] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:82:0) after 2m34s
[04:06:56.721] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:82:0)
[04:06:56.748] Build status: STARTED
[04:06:56.748] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:83:0) after 5m52s
[04:12:48.961] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:83:0)
[04:12:49.044] Build status: STARTED
[04:12:49.044] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:84:0) after 8m26s
[04:21:15.071] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:84:0)
[04:21:15.091] Build status: STARTED
[04:21:15.091] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:85:0) after 4m28s
[04:25:43.094] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:85:0)
[04:25:43.123] Build status: STARTED
[04:25:43.123] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:86:0) after 3m47s
[04:29:30.155] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:86:0)
[04:29:30.176] Build status: STARTED
[04:29:30.176] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:87:0) after 1m47s
[04:31:17.384] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:87:0)
[04:31:17.425] Build status: STARTED
[04:31:17.425] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:88:0) after 4m37s
[04:35:54.453] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:88:0)
[04:35:54.474] Build status: STARTED
[04:35:54.474] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:89:0) after 5m15s
[04:41:09.968] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:89:0)
[04:41:09.989] Build status: STARTED
[04:41:09.989] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:90:0) after 3m47s
[04:44:57.052] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:90:0)
[04:44:57.072] Build status: STARTED
[04:44:57.072] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:91:0) after 1m8s
[04:46:05.275] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:91:0)
[04:46:05.321] Build status: STARTED
[04:46:05.321] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:92:0) after 3m9s
[04:49:14.681] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:92:0)
[04:49:14.701] Build status: STARTED
[04:49:14.701] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:93:0) after 5m15s
[04:54:29.777] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:93:0)
[04:54:29.799] Build status: STARTED
[04:54:29.800] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:94:0) after 7m42s
[05:02:11.820] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:94:0)
[05:02:11.840] Build status: STARTED
[05:02:11.840] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:95:0) after 3m11s
[05:05:22.902] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:95:0)
[05:05:22.924] Build status: STARTED
[05:05:22.924] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:96:0) after 4m36s
[05:09:58.956] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:96:0)
[05:09:59.023] Build status: STARTED
[05:09:59.023] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:97:0) after 6m16s
[05:16:15.249] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:97:0)
[05:16:15.270] Build status: STARTED
[05:16:15.270] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:98:0) after 4m52s
[05:21:07.291] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:98:0)
[05:21:07.350] Build status: STARTED
[05:21:07.350] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:99:0) after 1m1s
[05:22:08.383] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:99:0)
[05:22:08.423] Build status: STARTED
[05:22:08.423] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:100:0) after 1m8s
[05:23:16.591] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:100:0)
[05:23:16.619] Build status: STARTED
[05:23:16.619] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:101:0) after 8m51s
[05:32:07.725] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:101:0)
[05:32:07.744] Build status: STARTED
[05:32:07.744] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:102:0) after 3m33s
[05:35:40.769] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:102:0)
[05:35:40.800] Build status: STARTED
[05:35:40.800] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:103:0) after 2m29s
[05:38:09.834] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:103:0)
[05:38:09.854] Build status: STARTED
[05:38:09.854] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:104:0) after 1m19s
[05:39:29.104] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:104:0)
[05:39:29.124] Build status: STARTED
[05:39:29.124] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:105:0) after 2m19s
[05:41:48.283] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:105:0)
[05:41:48.303] Build status: STARTED
[05:41:48.303] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:106:0) after 3m1s
[05:44:49.333] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:106:0)
[05:44:49.353] Build status: STARTED
[05:44:49.353] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:107:0) after 3m53s
[05:48:42.400] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:107:0)
[05:48:42.426] Build status: STARTED
[05:48:42.426] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:108:0) after 6m39s
[05:55:21.450] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:108:0)
[05:55:21.465] Build status: STARTED
[05:55:21.465] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:109:0) after 3m10s
[05:58:31.620] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:109:0)
[05:58:31.640] Build status: STARTED
[05:58:31.640] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:110:0) after 8m8s
[06:06:39.771] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:110:0)
[06:06:39.816] Build status: STARTED
[06:06:39.816] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:111:0) after 4m2s
[06:10:41.960] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:111:0)
[06:10:41.985] Build status: STARTED
[06:10:41.986] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:112:0) after 7m35s
[06:18:17.095] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:112:0)
[06:18:17.111] Build status: STARTED
[06:18:17.111] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:113:0) after 5m44s
[06:24:01.174] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:113:0)
[06:24:01.194] Build status: STARTED
[06:24:01.194] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:114:0) after 3m17s
[06:27:18.219] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:114:0)
[06:27:18.233] Build status: STARTED
[06:27:18.233] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:115:0) after 3m26s
[06:30:44.256] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:115:0)
[06:30:44.279] Build status: STARTED
[06:30:44.279] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:116:0) after 8m9s
[06:38:53.336] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:116:0)
[06:38:53.356] Build status: STARTED
[06:38:53.356] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:117:0) after 3m38s
[06:42:31.556] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:117:0)
[06:42:31.587] Build status: STARTED
[06:42:31.588] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:118:0) after 1m49s
[06:44:20.804] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:118:0)
[06:44:20.823] Build status: STARTED
[06:44:20.823] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:119:0) after 5m19s
[06:49:39.858] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:119:0)
[06:49:39.877] Build status: STARTED
[06:49:39.877] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:120:0) after 2m51s
[06:52:30.905] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:120:0)
[06:52:30.924] Build status: STARTED
[06:52:30.924] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:121:0) after 3m38s
[06:56:08.971] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:121:0)
[06:56:09.043] Build status: STARTED
[06:56:09.043] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:122:0) after 4m10s
[07:00:19.092] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:122:0)
[07:00:19.129] Build status: STARTED
[07:00:19.129] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:123:0) after 8m29s
[07:08:48.271] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:123:0)
[07:08:48.288] Build status: STARTED
[07:08:48.288] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:124:0) after 1m59s
[07:10:47.322] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:124:0)
[07:10:47.352] Build status: STARTED
[07:10:47.352] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:125:0) after 1m10s
[07:11:57.408] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:125:0)
[07:11:57.427] Build status: STARTED
[07:11:57.427] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (8 cores) (reclient):8924504385184184608:126:0) after 9m8s
[07:13:10.979] Received PubSub notification, asking Buildbucket for the build status
[07:13:11.002] Build:
{
"id": "8759074323193784577",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Comparison Windows (8 cores) (reclient)"
},
"number": 2956,
"createdBy": "project:chromium",
"createTime": "2024-01-12T20:53:24.684438228Z",
"startTime": "2024-01-12T20:53:25.874398Z",
"endTime": "2024-01-13T07:13:08.821024Z",
"updateTime": "2024-01-13T07:13:08.821024Z",
"status": "INFRA_FAILURE",
"statusDetails": {
"timeout": {
}
},
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "41c9c4ccb29242e349ea2962b696cfbf0d2fdc3c",
"ref": "refs/heads/main"
}
}
}
[07:13:11.002] Invocation finished in 10h19m47.600444152s with status FAILED