[01:52:57.442] New invocation is queued and will start shortly
[01:52:58.569] Starting the invocation (attempt 1)
[01:52:58.597] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2846bea2e15f3597d1e58f5cd75fb92d1656e0bb"
[01:52:58.597] Popped gitiles commit info from properties and tags
[01:52:58.597] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:52:58.597] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:52:58.597] Buildbucket request:
{
"requestId": "8863423182686683104",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Deterministic Linux (dbg)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "2846bea2e15f3597d1e58f5cd75fb92d1656e0bb",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8863423182686683104"
},
{
"key": "scheduler_job_id",
"value": "chromium/Deterministic Linux (dbg)"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[01:52:59.253] Scheduled build:
{
"id": "8697993120765399745",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Deterministic Linux (dbg)"
},
"number": 37324,
"createdBy": "project:chromium",
"createTime": "2025-11-17T01:52:58.655632417Z",
"updateTime": "2025-11-17T01:52:58.655632417Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "2846bea2e15f3597d1e58f5cd75fb92d1656e0bb",
"ref": "refs/heads/main"
}
}
}
[01:52:59.253] Task URL: https://cr-buildbucket.appspot.com/build/8697993120765399745
[01:52:59.253] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:2:0) after 7m55s
[01:52:59.368] Received PubSub notification, asking Buildbucket for the build status
[01:52:59.425] Build status: SCHEDULED
[01:53:06.478] Received PubSub notification, asking Buildbucket for the build status
[01:53:06.493] Build status: STARTED
[02:00:54.295] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:2:0)
[02:00:54.318] Build status: STARTED
[02:00:54.318] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:5:0) after 3m44s
[02:04:38.425] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:5:0)
[02:04:38.455] Build status: STARTED
[02:04:38.455] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:6:0) after 8m45s
[02:13:23.561] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:6:0)
[02:13:23.576] Build status: STARTED
[02:13:23.576] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:7:0) after 8m24s
[02:21:47.911] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:7:0)
[02:21:47.927] Build status: STARTED
[02:21:47.927] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:8:0) after 8m45s
[02:30:32.941] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:8:0)
[02:30:32.966] Build status: STARTED
[02:30:32.966] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:9:0) after 5m9s
[02:35:42.333] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:9:0)
[02:35:42.359] Build status: STARTED
[02:35:42.359] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:10:0) after 9m16s
[02:44:58.775] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:10:0)
[02:44:58.794] Build status: STARTED
[02:44:58.794] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:11:0) after 6m55s
[02:51:54.395] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:11:0)
[02:51:54.407] Build status: STARTED
[02:51:54.407] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:12:0) after 1m27s
[02:53:21.639] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:12:0)
[02:53:21.657] Build status: STARTED
[02:53:21.657] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:13:0) after 1m51s
[02:55:12.763] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:13:0)
[02:55:12.801] Build status: STARTED
[02:55:12.801] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:14:0) after 8m27s
[03:03:39.892] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:14:0)
[03:03:39.953] Build status: STARTED
[03:03:39.953] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:15:0) after 8m49s
[03:12:28.969] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:15:0)
[03:12:28.992] Build status: STARTED
[03:12:28.992] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:16:0) after 5m30s
[03:17:59.064] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:16:0)
[03:17:59.088] Build status: STARTED
[03:17:59.088] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:17:0) after 1m45s
[03:19:44.314] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:17:0)
[03:19:44.328] Build status: STARTED
[03:19:44.328] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:18:0) after 3m30s
[03:23:14.409] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:18:0)
[03:23:14.424] Build status: STARTED
[03:23:14.424] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:19:0) after 8m34s
[03:31:48.465] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:19:0)
[03:31:48.527] Build status: STARTED
[03:31:48.528] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:20:0) after 1m41s
[03:33:29.640] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:20:0)
[03:33:29.664] Build status: STARTED
[03:33:29.664] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:21:0) after 5m23s
[03:38:52.673] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:21:0)
[03:38:52.687] Build status: STARTED
[03:38:52.687] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:22:0) after 1m29s
[03:40:21.703] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:22:0)
[03:40:21.718] Build status: STARTED
[03:40:21.718] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:23:0) after 8m40s
[03:49:01.785] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:23:0)
[03:49:01.801] Build status: STARTED
[03:49:01.801] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:24:0) after 3m32s
[03:52:33.818] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:24:0)
[03:52:33.836] Build status: STARTED
[03:52:33.836] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:25:0) after 7m26s
[04:00:00.268] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:25:0)
[04:00:00.288] Build status: STARTED
[04:00:00.288] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:26:0) after 3m18s
[04:03:18.355] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:26:0)
[04:03:18.406] Build status: STARTED
[04:03:18.406] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:27:0) after 8m21s
[04:11:39.422] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:27:0)
[04:11:39.436] Build status: STARTED
[04:11:39.436] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:28:0) after 6m53s
[04:18:32.548] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:28:0)
[04:18:32.570] Build status: STARTED
[04:18:32.570] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:29:0) after 3m37s
[04:22:09.626] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:29:0)
[04:22:09.642] Build status: STARTED
[04:22:09.642] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:30:0) after 6m47s
[04:28:56.846] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:30:0)
[04:28:56.865] Build status: STARTED
[04:28:56.865] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:31:0) after 7m59s
[04:36:56.081] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:31:0)
[04:36:56.099] Build status: STARTED
[04:36:56.099] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:32:0) after 7m46s
[04:44:42.469] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:32:0)
[04:44:42.485] Build status: STARTED
[04:44:42.485] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:33:0) after 8m57s
[04:53:39.612] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:33:0)
[04:53:39.629] Build status: STARTED
[04:53:39.629] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:34:0) after 1m7s
[04:54:46.835] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:34:0)
[04:54:46.876] Build status: STARTED
[04:54:46.876] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:35:0) after 6m42s
[05:01:28.907] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:35:0)
[05:01:28.921] Build status: STARTED
[05:01:28.921] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:36:0) after 8m35s
[05:10:03.965] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:36:0)
[05:10:03.981] Build status: STARTED
[05:10:03.981] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:37:0) after 9m35s
[05:19:39.303] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:37:0)
[05:19:39.320] Build status: STARTED
[05:19:39.321] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:38:0) after 4m35s
[05:24:14.975] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:38:0)
[05:24:14.988] Build status: STARTED
[05:24:14.988] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:39:0) after 6m55s
[05:31:10.088] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:39:0)
[05:31:10.187] Build status: STARTED
[05:31:10.187] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:40:0) after 2m4s
[05:33:14.208] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:40:0)
[05:33:14.227] Build status: STARTED
[05:33:14.227] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:41:0) after 9m14s
[05:42:28.495] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:41:0)
[05:42:28.569] Build status: STARTED
[05:42:28.569] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:42:0) after 3m23s
[05:45:51.587] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:42:0)
[05:45:51.607] Build status: STARTED
[05:45:51.607] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:43:0) after 9m18s
[05:55:09.621] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:43:0)
[05:55:09.751] Build status: STARTED
[05:55:09.751] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:44:0) after 9m1s
[06:04:11.019] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:44:0)
[06:04:11.036] Build status: STARTED
[06:04:11.037] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:45:0) after 4m24s
[06:08:35.051] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:45:0)
[06:08:35.076] Build status: STARTED
[06:08:35.076] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:46:0) after 7m29s
[06:16:04.142] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:46:0)
[06:16:04.165] Build status: STARTED
[06:16:04.165] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:47:0) after 6m26s
[06:22:30.178] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:47:0)
[06:22:30.195] Build status: STARTED
[06:22:30.195] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:48:0) after 1m54s
[06:24:24.208] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:48:0)
[06:24:24.224] Build status: STARTED
[06:24:24.224] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:49:0) after 4m17s
[06:28:41.237] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:49:0)
[06:28:41.250] Build status: STARTED
[06:28:41.250] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:50:0) after 8m43s
[06:37:24.384] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:50:0)
[06:37:24.452] Build status: STARTED
[06:37:24.452] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:51:0) after 9m39s
[06:47:03.482] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:51:0)
[06:47:03.498] Build status: STARTED
[06:47:03.498] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:52:0) after 3m22s
[06:50:25.656] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:52:0)
[06:50:25.804] Build status: STARTED
[06:50:25.804] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:53:0) after 6m21s
[06:56:46.910] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:53:0)
[06:56:47.079] Build status: STARTED
[06:56:47.079] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:54:0) after 5m21s
[07:02:08.409] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:54:0)
[07:02:08.478] Build status: STARTED
[07:02:08.478] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:55:0) after 2m3s
[07:04:11.495] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:55:0)
[07:04:11.511] Build status: STARTED
[07:04:11.511] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:56:0) after 6m19s
[07:10:30.584] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:56:0)
[07:10:30.642] Build status: STARTED
[07:10:30.642] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:57:0) after 8m36s
[07:19:06.835] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:57:0)
[07:19:06.885] Build status: STARTED
[07:19:06.885] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:58:0) after 1m12s
[07:20:19.023] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:58:0)
[07:20:19.037] Build status: STARTED
[07:20:19.037] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8863423182686683104:59:0) after 9m14s
[07:21:09.626] Received PubSub notification, asking Buildbucket for the build status
[07:21:09.643] Build:
{
"id": "8697993120765399745",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Deterministic Linux (dbg)"
},
"number": 37324,
"createdBy": "project:chromium",
"createTime": "2025-11-17T01:52:58.655632417Z",
"startTime": "2025-11-17T01:53:06.291211795Z",
"endTime": "2025-11-17T07:21:09.128442262Z",
"updateTime": "2025-11-17T07:21:09.128442262Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "2846bea2e15f3597d1e58f5cd75fb92d1656e0bb",
"ref": "refs/heads/main"
}
}
}
[07:21:09.643] Invocation finished in 5h28m12.203923847s with status SUCCEEDED