[22:42:14.708] New invocation is queued and will start shortly
[22:42:16.170] Starting the invocation (attempt 1)
[22:42:16.238] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d4cfff868d166b9495845addbda55c7f4a4f08cd"
[22:42:16.238] Popped gitiles commit info from properties and tags
[22:42:16.238] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:42:16.239] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:42:16.240] Buildbucket request:
{
"requestId": "8913807094585513584",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Comparison Windows (reclient)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d4cfff868d166b9495845addbda55c7f4a4f08cd",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8913807094585513584"
},
{
"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"
}
}
[22:42:17.116] Scheduled build:
{
"id": "8748377032206838401",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Comparison Windows (reclient)"
},
"number": 10746,
"createdBy": "project:chromium",
"createTime": "2024-05-09T22:42:16.354025536Z",
"updateTime": "2024-05-09T22:42:16.354025536Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d4cfff868d166b9495845addbda55c7f4a4f08cd",
"ref": "refs/heads/main"
}
}
}
[22:42:17.116] Task URL: https://cr-buildbucket.appspot.com/build/8748377032206838401
[22:42:17.116] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:2:0) after 2m16s
[22:42:17.859] Received PubSub notification, asking Buildbucket for the build status
[22:42:17.885] Build status: SCHEDULED
[22:42:40.960] Received PubSub notification, asking Buildbucket for the build status
[22:42:40.998] Build status: STARTED
[22:44:33.164] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:2:0)
[22:44:33.182] Build status: STARTED
[22:44:33.182] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:5:0) after 3m16s
[22:47:49.189] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:5:0)
[22:47:49.211] Build status: STARTED
[22:47:49.211] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:6:0) after 9m28s
[22:57:17.241] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:6:0)
[22:57:17.277] Build status: STARTED
[22:57:17.277] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:7:0) after 3m3s
[23:00:20.328] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:7:0)
[23:00:20.356] Build status: STARTED
[23:00:20.356] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:8:0) after 4m6s
[23:04:26.360] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:8:0)
[23:04:26.396] Build status: STARTED
[23:04:26.397] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:9:0) after 8m50s
[23:13:16.479] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:9:0)
[23:13:16.523] Build status: STARTED
[23:13:16.523] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:10:0) after 4m2s
[23:17:18.555] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:10:0)
[23:17:18.575] Build status: STARTED
[23:17:18.575] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:11:0) after 8m36s
[23:25:54.608] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:11:0)
[23:25:54.635] Build status: STARTED
[23:25:54.635] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:12:0) after 3m9s
[23:29:03.669] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:12:0)
[23:29:03.690] Build status: STARTED
[23:29:03.690] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:13:0) after 2m31s
[23:31:34.703] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:13:0)
[23:31:34.723] Build status: STARTED
[23:31:34.723] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:14:0) after 6m50s
[23:38:24.746] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:14:0)
[23:38:24.770] Build status: STARTED
[23:38:24.770] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:15:0) after 5m56s
[23:44:20.808] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:15:0)
[23:44:20.887] Build status: STARTED
[23:44:20.887] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:16:0) after 8m26s
[23:52:46.926] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:16:0)
[23:52:46.999] Build status: STARTED
[23:52:46.999] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:17:0) after 1m23s
[23:54:09.976] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:17:0)
[23:54:09.994] Build status: STARTED
[23:54:09.994] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:18:0) after 4m31s
[23:58:41.070] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:18:0)
[23:58:41.123] Build status: STARTED
[23:58:41.123] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:19:0) after 4m19s
[00:03:00.189] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:19:0)
[00:03:00.230] Build status: STARTED
[00:03:00.230] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:20:0) after 4m14s
[00:07:14.261] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:20:0)
[00:07:14.277] Build status: STARTED
[00:07:14.277] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:21:0) after 3m34s
[00:10:48.308] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:21:0)
[00:10:48.330] Build status: STARTED
[00:10:48.330] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:22:0) after 1m50s
[00:12:38.356] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:22:0)
[00:12:38.375] Build status: STARTED
[00:12:38.375] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:23:0) after 2m46s
[00:15:24.398] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:23:0)
[00:15:24.421] Build status: STARTED
[00:15:24.421] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:24:0) after 6m47s
[00:22:11.450] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:24:0)
[00:22:11.469] Build status: STARTED
[00:22:11.469] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:25:0) after 9m54s
[00:32:05.612] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:25:0)
[00:32:05.813] Build status: STARTED
[00:32:05.813] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:26:0) after 5m21s
[00:37:26.886] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:26:0)
[00:37:26.906] Build status: STARTED
[00:37:26.906] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:27:0) after 3m16s
[00:40:43.078] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:27:0)
[00:40:43.095] Build status: STARTED
[00:40:43.095] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:28:0) after 4m37s
[00:45:20.179] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:28:0)
[00:45:20.209] Build status: STARTED
[00:45:20.209] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:29:0) after 9m32s
[00:54:52.265] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:29:0)
[00:54:52.302] Build status: STARTED
[00:54:52.302] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:30:0) after 3m22s
[00:58:14.358] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:30:0)
[00:58:14.407] Build status: STARTED
[00:58:14.407] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:31:0) after 9m31s
[01:07:45.532] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:31:0)
[01:07:45.549] Build status: STARTED
[01:07:45.549] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:32:0) after 7m56s
[01:15:41.744] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:32:0)
[01:15:41.765] Build status: STARTED
[01:15:41.765] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:33:0) after 9m13s
[01:24:54.791] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:33:0)
[01:24:54.810] Build status: STARTED
[01:24:54.810] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:34:0) after 5m49s
[01:30:44.001] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:34:0)
[01:30:44.023] Build status: STARTED
[01:30:44.023] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:35:0) after 9m46s
[01:40:30.155] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:35:0)
[01:40:30.235] Build status: STARTED
[01:40:30.235] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:36:0) after 7m37s
[01:48:07.464] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:36:0)
[01:48:07.484] Build status: STARTED
[01:48:07.484] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:37:0) after 9m23s
[01:57:30.508] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:37:0)
[01:57:30.530] Build status: STARTED
[01:57:30.530] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:38:0) after 2m17s
[01:59:47.654] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:38:0)
[01:59:47.672] Build status: STARTED
[01:59:47.672] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:39:0) after 8m32s
[02:08:20.042] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:39:0)
[02:08:20.062] Build status: STARTED
[02:08:20.062] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:40:0) after 9m22s
[02:17:42.098] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:40:0)
[02:17:42.176] Build status: STARTED
[02:17:42.176] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:41:0) after 3m40s
[02:21:22.622] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:41:0)
[02:21:22.644] Build status: STARTED
[02:21:22.644] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:42:0) after 7m29s
[02:28:51.667] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:42:0)
[02:28:51.805] Build status: STARTED
[02:28:51.805] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:43:0) after 8m17s
[02:37:08.840] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:43:0)
[02:37:08.861] Build status: STARTED
[02:37:08.861] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:44:0) after 6m10s
[02:43:18.894] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:44:0)
[02:43:19.014] Build status: STARTED
[02:43:19.014] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:45:0) after 8m6s
[02:51:25.035] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:45:0)
[02:51:25.060] Build status: STARTED
[02:51:25.060] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:46:0) after 8m5s
[02:59:30.825] Handling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:46:0)
[02:59:30.849] Build status: STARTED
[02:59:30.849] Scheduling timer "check-buildbucket-build-status" (chromium/Comparison Windows (reclient):8913807094585513584:47:0) after 6m44s
[03:01:25.837] Received PubSub notification, asking Buildbucket for the build status
[03:01:25.884] Build:
{
"id": "8748377032206838401",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Comparison Windows (reclient)"
},
"number": 10746,
"createdBy": "project:chromium",
"createTime": "2024-05-09T22:42:16.354025536Z",
"startTime": "2024-05-09T22:42:40.698864849Z",
"endTime": "2024-05-10T03:01:24.946728071Z",
"updateTime": "2024-05-10T03:01:24.946728071Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d4cfff868d166b9495845addbda55c7f4a4f08cd",
"ref": "refs/heads/main"
}
}
}
[03:01:25.884] Invocation finished in 4h19m11.183308967s with status SUCCEEDED