[23:34:06.229] New invocation is queued and will start shortly
[23:34:07.305] Starting the invocation (attempt 1)
[23:34:07.335] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5636ed768d6eea8b8cf32a2b39466ee0cb7e9f6b"
[23:34:07.335] Popped gitiles commit info from properties and tags
[23:34:07.335] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:34:07.337] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:34:07.337] Buildbucket request:
{
"requestId": "8887258920773668032",
"builder": {
"project": "chromium",
"bucket": "reclient",
"builder": "Win x64 Cross Builder (reclient compare)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5636ed768d6eea8b8cf32a2b39466ee0cb7e9f6b",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8887258920773668032"
},
{
"key": "scheduler_job_id",
"value": "chromium/Win x64 Cross Builder (reclient compare)"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[23:34:07.881] Scheduled build:
{
"id": "8721828858879195489",
"builder": {
"project": "chromium",
"bucket": "reclient",
"builder": "Win x64 Cross Builder (reclient compare)"
},
"number": 3336,
"createdBy": "project:chromium",
"createTime": "2025-02-26T23:34:07.404272445Z",
"updateTime": "2025-02-26T23:34:07.404272445Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5636ed768d6eea8b8cf32a2b39466ee0cb7e9f6b",
"ref": "refs/heads/main"
}
}
}
[23:34:07.881] Task URL: https://cr-buildbucket.appspot.com/build/8721828858879195489
[23:34:07.881] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:2:0) after 8m39s
[23:34:14.804] Received PubSub notification, asking Buildbucket for the build status
[23:34:14.826] Build status: SCHEDULED
[23:41:20.544] Received PubSub notification, asking Buildbucket for the build status
[23:41:20.572] Build status: STARTED
[23:42:46.918] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:2:0)
[23:42:46.940] Build status: STARTED
[23:42:46.940] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:5:0) after 9m50s
[23:52:36.973] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:5:0)
[23:52:36.997] Build status: STARTED
[23:52:36.997] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:6:0) after 4m25s
[23:57:02.034] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:6:0)
[23:57:02.061] Build status: STARTED
[23:57:02.061] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:7:0) after 4m22s
[00:01:24.106] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:7:0)
[00:01:24.200] Build status: STARTED
[00:01:24.200] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:8:0) after 8m29s
[00:09:53.271] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:8:0)
[00:09:53.293] Build status: STARTED
[00:09:53.293] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:9:0) after 5m37s
[00:15:30.340] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:9:0)
[00:15:30.402] Build status: STARTED
[00:15:30.402] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:10:0) after 3m42s
[00:19:12.464] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:10:0)
[00:19:12.484] Build status: STARTED
[00:19:12.484] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:11:0) after 2m34s
[00:21:46.611] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:11:0)
[00:21:46.648] Build status: STARTED
[00:21:46.648] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:12:0) after 3m53s
[00:25:39.674] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:12:0)
[00:25:39.696] Build status: STARTED
[00:25:39.696] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:13:0) after 2m52s
[00:28:31.834] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:13:0)
[00:28:31.865] Build status: STARTED
[00:28:31.865] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:14:0) after 1m20s
[00:29:51.890] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:14:0)
[00:29:51.943] Build status: STARTED
[00:29:51.943] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:15:0) after 1m58s
[00:31:49.995] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:15:0)
[00:31:50.024] Build status: STARTED
[00:31:50.024] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:16:0) after 8m37s
[00:40:27.234] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:16:0)
[00:40:27.260] Build status: STARTED
[00:40:27.260] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:17:0) after 3m19s
[00:43:46.282] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:17:0)
[00:43:46.307] Build status: STARTED
[00:43:46.308] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:18:0) after 8m12s
[00:51:58.377] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:18:0)
[00:51:58.404] Build status: STARTED
[00:51:58.404] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:19:0) after 8m22s
[01:00:20.463] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:19:0)
[01:00:20.486] Build status: STARTED
[01:00:20.486] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:20:0) after 5m1s
[01:05:21.534] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:20:0)
[01:05:21.563] Build status: STARTED
[01:05:21.563] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:21:0) after 3m5s
[01:08:26.619] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:21:0)
[01:08:26.636] Build status: STARTED
[01:08:26.636] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:22:0) after 6m28s
[01:14:54.723] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:22:0)
[01:14:55.318] Build status: STARTED
[01:14:55.318] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:23:0) after 5m30s
[01:20:25.354] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:23:0)
[01:20:25.374] Build status: STARTED
[01:20:25.374] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:24:0) after 5m11s
[01:25:36.399] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:24:0)
[01:25:36.414] Build status: STARTED
[01:25:36.415] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:25:0) after 2m16s
[01:27:52.504] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:25:0)
[01:27:52.538] Build status: STARTED
[01:27:52.538] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:26:0) after 8m20s
[01:36:12.735] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:26:0)
[01:36:12.756] Build status: STARTED
[01:36:12.756] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:27:0) after 8m54s
[01:45:06.824] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:27:0)
[01:45:06.842] Build status: STARTED
[01:45:06.842] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:28:0) after 3m16s
[01:48:22.836] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:28:0)
[01:48:22.903] Build status: STARTED
[01:48:22.903] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:29:0) after 7m57s
[01:56:19.935] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:29:0)
[01:56:19.955] Build status: STARTED
[01:56:19.955] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:30:0) after 1m18s
[01:57:37.990] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:30:0)
[01:57:38.013] Build status: STARTED
[01:57:38.013] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:31:0) after 1m10s
[01:58:48.063] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:31:0)
[01:58:48.084] Build status: STARTED
[01:58:48.084] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:32:0) after 5m45s
[02:04:33.206] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:32:0)
[02:04:33.230] Build status: STARTED
[02:04:33.230] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:33:0) after 9m54s
[02:14:27.297] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:33:0)
[02:14:27.315] Build status: STARTED
[02:14:27.315] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:34:0) after 1m40s
[02:16:07.354] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:34:0)
[02:16:07.431] Build status: STARTED
[02:16:07.432] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:35:0) after 5m48s
[02:21:55.475] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:35:0)
[02:21:55.491] Build status: STARTED
[02:21:55.491] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:36:0) after 3m7s
[02:25:02.524] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:36:0)
[02:25:02.546] Build status: STARTED
[02:25:02.547] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:37:0) after 1m27s
[02:26:29.641] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:37:0)
[02:26:29.662] Build status: STARTED
[02:26:29.662] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:38:0) after 9m46s
[02:36:15.696] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:38:0)
[02:36:15.724] Build status: STARTED
[02:36:15.724] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:39:0) after 5m3s
[02:41:18.784] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:39:0)
[02:41:18.801] Build status: STARTED
[02:41:18.801] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:40:0) after 6m37s
[02:47:55.847] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:40:0)
[02:47:55.865] Build status: STARTED
[02:47:55.866] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:41:0) after 1m31s
[02:49:26.928] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:41:0)
[02:49:26.949] Build status: STARTED
[02:49:26.949] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:42:0) after 9m26s
[02:58:53.409] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:42:0)
[02:58:53.464] Build status: STARTED
[02:58:53.464] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:43:0) after 8m20s
[03:07:13.506] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:43:0)
[03:07:13.534] Build status: STARTED
[03:07:13.534] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:44:0) after 1m41s
[03:08:54.732] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:44:0)
[03:08:54.749] Build status: STARTED
[03:08:54.749] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:45:0) after 2m14s
[03:11:08.834] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:45:0)
[03:11:08.869] Build status: STARTED
[03:11:08.869] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:46:0) after 9m18s
[03:20:26.906] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:46:0)
[03:20:26.937] Build status: STARTED
[03:20:26.937] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:47:0) after 9m17s
[03:29:43.974] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:47:0)
[03:29:43.993] Build status: STARTED
[03:29:43.993] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:48:0) after 5m47s
[03:35:31.018] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:48:0)
[03:35:31.039] Build status: STARTED
[03:35:31.039] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:49:0) after 5m47s
[03:41:18.083] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:49:0)
[03:41:18.098] Build status: STARTED
[03:41:18.098] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:50:0) after 1m0s
[03:42:18.137] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:50:0)
[03:42:18.162] Build status: STARTED
[03:42:18.162] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:51:0) after 6m11s
[03:48:29.235] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:51:0)
[03:48:29.255] Build status: STARTED
[03:48:29.255] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:52:0) after 8m1s
[03:56:30.336] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:52:0)
[03:56:30.372] Build status: STARTED
[03:56:30.372] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:53:0) after 4m20s
[04:00:50.387] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:53:0)
[04:00:50.408] Build status: STARTED
[04:00:50.408] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:54:0) after 7m21s
[04:08:11.520] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:54:0)
[04:08:11.547] Build status: STARTED
[04:08:11.547] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:55:0) after 2m47s
[04:10:58.629] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:55:0)
[04:10:58.690] Build status: STARTED
[04:10:58.690] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:56:0) after 4m25s
[04:15:23.803] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:56:0)
[04:15:23.820] Build status: STARTED
[04:15:23.820] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:57:0) after 7m2s
[04:22:25.919] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:57:0)
[04:22:25.945] Build status: STARTED
[04:22:25.945] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:58:0) after 9m46s
[04:32:11.968] Handling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:58:0)
[04:32:11.987] Build status: STARTED
[04:32:11.987] Scheduling timer "check-buildbucket-build-status" (chromium/Win x64 Cross Builder (reclient compare):8887258920773668032:59:0) after 7m48s
[04:39:19.732] Received PubSub notification, asking Buildbucket for the build status
[04:39:19.747] Build:
{
"id": "8721828858879195489",
"builder": {
"project": "chromium",
"bucket": "reclient",
"builder": "Win x64 Cross Builder (reclient compare)"
},
"number": 3336,
"createdBy": "project:chromium",
"createTime": "2025-02-26T23:34:07.404272445Z",
"startTime": "2025-02-26T23:41:15.242747826Z",
"endTime": "2025-02-27T04:37:50.179770647Z",
"updateTime": "2025-02-27T04:37:50.179770647Z",
"status": "INFRA_FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5636ed768d6eea8b8cf32a2b39466ee0cb7e9f6b",
"ref": "refs/heads/main"
}
}
}
[04:39:19.747] Invocation finished in 5h5m13.534229204s with status FAILED