[19:17:21.003] New invocation is queued and will start shortly
[19:17:22.340] Starting the invocation (attempt 1)
[19:17:22.366] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8d83ccd9e6d549c47330c400eaa172371b9b5dc9"
[19:17:22.367] Popped gitiles commit info from properties and tags
[19:17:22.367] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:17:22.367] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:17:22.367] Buildbucket request:
{
"requestId": "8902042379836374432",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Comparison Windows (reclient)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "8d83ccd9e6d549c47330c400eaa172371b9b5dc9",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8902042379836374432"
},
{
"key": "scheduler_job_id",
"value": "chromium/Comparison Windows (reclient)"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[19:17:23.068] Scheduled build:
{
"id": "8736612317665584609",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Comparison Windows (reclient)"
},
"number": 12032,
"createdBy": "project:chromium",
"createTime": "2024-09-16T19:17:22.451490649Z",
"updateTime": "2024-09-16T19:17:22.451490649Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "8d83ccd9e6d549c47330c400eaa172371b9b5dc9",
"ref": "refs/heads/main"
}
}
}
[19:17:23.068] Task URL: https://cr-buildbucket.appspot.com/build/8736612317665584609
[19:17:23.068] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:2:0) after 9m9s
[19:17:23.976] Received PubSub notification, asking Buildbucket for the build status
[19:17:23.995] Build status: SCHEDULED
[19:17:30.529] Received PubSub notification, asking Buildbucket for the build status
[19:17:30.547] Build status: STARTED
[19:26:32.092] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:2:0)
[19:26:32.115] Build status: STARTED
[19:26:32.115] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:5:0) after 4m23s
[19:30:55.188] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:5:0)
[19:30:55.204] Build status: STARTED
[19:30:55.204] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:6:0) after 3m27s
[19:34:22.256] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:6:0)
[19:34:22.345] Build status: STARTED
[19:34:22.345] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:7:0) after 9m58s
[19:44:20.415] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:7:0)
[19:44:20.436] Build status: STARTED
[19:44:20.436] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:8:0) after 5m16s
[19:49:36.478] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:8:0)
[19:49:36.509] Build status: STARTED
[19:49:36.509] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:9:0) after 7m8s
[19:56:44.555] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:9:0)
[19:56:44.602] Build status: STARTED
[19:56:44.602] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:10:0) after 7m45s
[20:04:29.620] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:10:0)
[20:04:29.652] Build status: STARTED
[20:04:29.652] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:11:0) after 3m48s
[20:08:17.745] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:11:0)
[20:08:17.769] Build status: STARTED
[20:08:17.769] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:12:0) after 6m46s
[20:15:03.779] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:12:0)
[20:15:03.834] Build status: STARTED
[20:15:03.834] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:13:0) after 1m57s
[20:17:00.916] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:13:0)
[20:17:00.991] Build status: STARTED
[20:17:00.992] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:14:0) after 8m33s
[20:25:34.087] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:14:0)
[20:25:34.117] Build status: STARTED
[20:25:34.117] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:15:0) after 7m47s
[20:33:21.262] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:15:0)
[20:33:21.280] Build status: STARTED
[20:33:21.280] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:16:0) after 6m20s
[20:39:41.299] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:16:0)
[20:39:41.318] Build status: STARTED
[20:39:41.318] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:17:0) after 2m14s
[20:41:55.342] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:17:0)
[20:41:55.366] Build status: STARTED
[20:41:55.366] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:18:0) after 3m27s
[20:45:22.481] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:18:0)
[20:45:22.499] Build status: STARTED
[20:45:22.499] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:19:0) after 5m19s
[20:50:41.698] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:19:0)
[20:50:41.742] Build status: STARTED
[20:50:41.742] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:20:0) after 7m26s
[20:58:07.782] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:20:0)
[20:58:07.807] Build status: STARTED
[20:58:07.807] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:21:0) after 8m42s
[21:06:49.939] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:21:0)
[21:06:49.962] Build status: STARTED
[21:06:49.962] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:22:0) after 1m1s
[21:07:51.084] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:22:0)
[21:07:51.174] Build status: STARTED
[21:07:51.174] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:23:0) after 7m5s
[21:14:56.190] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:23:0)
[21:14:56.209] Build status: STARTED
[21:14:56.209] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:24:0) after 4m9s
[21:19:05.205] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:24:0)
[21:19:05.228] Build status: STARTED
[21:19:05.228] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:25:0) after 7m5s
[21:26:10.254] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:25:0)
[21:26:10.276] Build status: STARTED
[21:26:10.276] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:26:0) after 6m5s
[21:32:15.295] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:26:0)
[21:32:15.314] Build status: STARTED
[21:32:15.314] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:27:0) after 7m59s
[21:40:14.346] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:27:0)
[21:40:14.363] Build status: STARTED
[21:40:14.363] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:28:0) after 8m27s
[21:48:41.381] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:28:0)
[21:48:41.403] Build status: STARTED
[21:48:41.403] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:29:0) after 4m13s
[21:52:54.424] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:29:0)
[21:52:54.470] Build status: STARTED
[21:52:54.470] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:30:0) after 2m49s
[21:55:43.443] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:30:0)
[21:55:43.463] Build status: STARTED
[21:55:43.463] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:31:0) after 4m59s
[22:00:42.491] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:31:0)
[22:00:42.512] Build status: STARTED
[22:00:42.512] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:32:0) after 7m13s
[22:07:55.502] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:32:0)
[22:07:55.520] Build status: STARTED
[22:07:55.520] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:33:0) after 8m24s
[22:16:19.552] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:33:0)
[22:16:19.570] Build status: STARTED
[22:16:19.570] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:34:0) after 7m42s
[22:24:01.589] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:34:0)
[22:24:01.607] Build status: STARTED
[22:24:01.607] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:35:0) after 3m27s
[22:27:28.636] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:35:0)
[22:27:28.655] Build status: STARTED
[22:27:28.655] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:36:0) after 3m42s
[22:31:10.724] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:36:0)
[22:31:10.745] Build status: STARTED
[22:31:10.745] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:37:0) after 5m1s
[22:36:11.777] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:37:0)
[22:36:11.799] Build status: STARTED
[22:36:11.799] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:38:0) after 8m59s
[22:45:10.885] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:38:0)
[22:45:10.904] Build status: STARTED
[22:45:10.904] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:39:0) after 1m2s
[22:46:12.898] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:39:0)
[22:46:12.924] Build status: STARTED
[22:46:12.924] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:40:0) after 4m14s
[22:50:27.058] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:40:0)
[22:50:27.076] Build status: STARTED
[22:50:27.076] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:41:0) after 9m18s
[22:59:45.097] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:41:0)
[22:59:45.116] Build status: STARTED
[22:59:45.116] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:42:0) after 4m20s
[23:04:05.152] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:42:0)
[23:04:05.200] Build status: STARTED
[23:04:05.200] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:43:0) after 4m54s
[23:08:59.222] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:43:0)
[23:08:59.241] Build status: STARTED
[23:08:59.241] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:44:0) after 6m26s
[23:15:25.356] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:44:0)
[23:15:25.376] Build status: STARTED
[23:15:25.376] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:45:0) after 5m39s
[23:21:04.373] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:45:0)
[23:21:04.398] Build status: STARTED
[23:21:04.398] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:46:0) after 6m24s
[23:27:28.558] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:46:0)
[23:27:28.584] Build status: STARTED
[23:27:28.584] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:47:0) after 5m35s
[23:33:03.603] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:47:0)
[23:33:03.631] Build status: STARTED
[23:33:03.631] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:48:0) after 3m29s
[23:36:32.706] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:48:0)
[23:36:32.802] Build status: STARTED
[23:36:32.802] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:49:0) after 1m12s
[23:37:44.817] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:49:0)
[23:37:45.016] Build status: STARTED
[23:37:45.017] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:50:0) after 3m58s
[23:41:43.050] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:50:0)
[23:41:43.083] Build status: STARTED
[23:41:43.083] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:51:0) after 1m55s
[23:43:38.105] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:51:0)
[23:43:38.129] Build status: STARTED
[23:43:38.129] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:52:0) after 9m17s
[23:52:55.148] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:52:0)
[23:52:55.165] Build status: STARTED
[23:52:55.165] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:53:0) after 4m45s
[23:57:40.184] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:53:0)
[23:57:40.201] Build status: STARTED
[23:57:40.201] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:54:0) after 8m34s
[00:06:14.221] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:54:0)
[00:06:14.238] Build status: STARTED
[00:06:14.238] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:55:0) after 1m6s
[00:07:20.222] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:55:0)
[00:07:20.239] Build status: STARTED
[00:07:20.239] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:56:0) after 4m43s
[00:12:03.235] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:56:0)
[00:12:03.257] Build status: STARTED
[00:12:03.257] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:57:0) after 1m58s
[00:14:01.284] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:57:0)
[00:14:01.302] Build status: STARTED
[00:14:01.303] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:58:0) after 4m46s
[00:18:47.322] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:58:0)
[00:18:47.347] Build status: STARTED
[00:18:47.347] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:59:0) after 8m12s
[00:26:59.443] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:59:0)
[00:26:59.541] Build status: STARTED
[00:26:59.541] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:60:0) after 6m36s
[00:33:35.563] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:60:0)
[00:33:35.596] Build status: STARTED
[00:33:35.596] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8902042379836374432:61:0) after 9m29s
[00:37:33.210] Received PubSub notification, asking Buildbucket for the build status
[00:37:33.228] Build:
{
"id": "8736612317665584609",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Comparison Windows (reclient)"
},
"number": 12032,
"createdBy": "project:chromium",
"createTime": "2024-09-16T19:17:22.451490649Z",
"startTime": "2024-09-16T19:17:30.330774703Z",
"endTime": "2024-09-17T00:37:32.833054170Z",
"updateTime": "2024-09-17T00:37:32.833054170Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "8d83ccd9e6d549c47330c400eaa172371b9b5dc9",
"ref": "refs/heads/main"
}
}
}
[00:37:33.228] Invocation finished in 5h20m12.229734101s with status SUCCEEDED