[12:38:57.273] New invocation is queued and will start shortly
[12:38:58.317] Starting the invocation (attempt 1)
[12:38:58.344] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a3827d6816cb0480c9a0c9deb4df770e98020ee6"
[12:38:58.344] Popped gitiles commit info from properties and tags
[12:38:58.344] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:38:58.344] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:38:58.344] Buildbucket request:
{
"requestId": "8857765528145188592",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Deterministic Linux (dbg)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "a3827d6816cb0480c9a0c9deb4df770e98020ee6",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8857765528145188592"
},
{
"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"
}
}
[12:38:58.978] Scheduled build:
{
"id": "8692335466302831409",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Deterministic Linux (dbg)"
},
"number": 37598,
"createdBy": "project:chromium",
"createTime": "2026-01-18T12:38:58.407272484Z",
"updateTime": "2026-01-18T12:38:58.407272484Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "a3827d6816cb0480c9a0c9deb4df770e98020ee6",
"ref": "refs/heads/main"
}
}
}
[12:38:58.978] Task URL: https://cr-buildbucket.appspot.com/build/8692335466302831409
[12:38:58.978] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:2:0) after 5m46s
[12:39:00.012] Received PubSub notification, asking Buildbucket for the build status
[12:39:00.029] Build status: SCHEDULED
[12:39:03.555] Received PubSub notification, asking Buildbucket for the build status
[12:39:03.573] Build status: STARTED
[12:44:44.991] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:2:0)
[12:44:45.003] Build status: STARTED
[12:44:45.003] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:5:0) after 5m44s
[12:50:29.425] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:5:0)
[12:50:29.443] Build status: STARTED
[12:50:29.443] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:6:0) after 1m59s
[12:52:28.439] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:6:0)
[12:52:28.524] Build status: STARTED
[12:52:28.524] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:7:0) after 5m18s
[12:57:46.626] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:7:0)
[12:57:46.642] Build status: STARTED
[12:57:46.642] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:8:0) after 1m9s
[12:58:55.794] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:8:0)
[12:58:55.811] Build status: STARTED
[12:58:55.811] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:9:0) after 9m7s
[13:08:02.908] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:9:0)
[13:08:02.966] Build status: STARTED
[13:08:02.966] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:10:0) after 1m4s
[13:09:07.017] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:10:0)
[13:09:07.044] Build status: STARTED
[13:09:07.044] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:11:0) after 4m40s
[13:13:47.128] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:11:0)
[13:13:47.186] Build status: STARTED
[13:13:47.186] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:12:0) after 9m42s
[13:23:29.201] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:12:0)
[13:23:29.215] Build status: STARTED
[13:23:29.215] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:13:0) after 2m27s
[13:25:56.237] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:13:0)
[13:25:56.254] Build status: STARTED
[13:25:56.254] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:14:0) after 5m31s
[13:31:27.367] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:14:0)
[13:31:27.388] Build status: STARTED
[13:31:27.388] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:15:0) after 6m38s
[13:38:05.724] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:15:0)
[13:38:05.739] Build status: STARTED
[13:38:05.739] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:16:0) after 5m31s
[13:43:36.756] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:16:0)
[13:43:36.773] Build status: STARTED
[13:43:36.773] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:17:0) after 3m8s
[13:46:44.953] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:17:0)
[13:46:44.964] Build status: STARTED
[13:46:44.964] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:18:0) after 8m46s
[13:55:31.481] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:18:0)
[13:55:31.517] Build status: STARTED
[13:55:31.517] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:19:0) after 6m1s
[14:01:32.534] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:19:0)
[14:01:32.553] Build status: STARTED
[14:01:32.553] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:20:0) after 6m47s
[14:08:19.748] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:20:0)
[14:08:19.763] Build status: STARTED
[14:08:19.763] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:21:0) after 7m57s
[14:16:17.076] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:21:0)
[14:16:17.253] Build status: STARTED
[14:16:17.253] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:22:0) after 4m49s
[14:21:06.463] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:22:0)
[14:21:06.478] Build status: STARTED
[14:21:06.478] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:23:0) after 3m19s
[14:24:25.493] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:23:0)
[14:24:25.531] Build status: STARTED
[14:24:25.531] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:24:0) after 2m7s
[14:26:32.545] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:24:0)
[14:26:32.560] Build status: STARTED
[14:26:32.560] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:25:0) after 9m58s
[14:36:30.628] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:25:0)
[14:36:30.645] Build status: STARTED
[14:36:30.645] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:26:0) after 7m37s
[14:44:07.786] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:26:0)
[14:44:07.807] Build status: STARTED
[14:44:07.807] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:27:0) after 6m3s
[14:50:11.006] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:27:0)
[14:50:11.023] Build status: STARTED
[14:50:11.023] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:28:0) after 4m56s
[14:55:07.412] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:28:0)
[14:55:07.516] Build status: STARTED
[14:55:07.516] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:29:0) after 8m20s
[15:03:27.868] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:29:0)
[15:03:27.928] Build status: STARTED
[15:03:27.929] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:30:0) after 3m36s
[15:07:03.954] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:30:0)
[15:07:03.977] Build status: STARTED
[15:07:03.977] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:31:0) after 7m19s
[15:14:22.997] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:31:0)
[15:14:23.064] Build status: STARTED
[15:14:23.064] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:32:0) after 4m9s
[15:18:32.520] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:32:0)
[15:18:32.536] Build status: STARTED
[15:18:32.536] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:33:0) after 4m25s
[15:22:57.552] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:33:0)
[15:22:57.569] Build status: STARTED
[15:22:57.569] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:34:0) after 6m16s
[15:29:13.695] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:34:0)
[15:29:13.725] Build status: STARTED
[15:29:13.725] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:35:0) after 5m21s
[15:34:34.758] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:35:0)
[15:34:34.782] Build status: STARTED
[15:34:34.782] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:36:0) after 7m1s
[15:41:35.901] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:36:0)
[15:41:35.914] Build status: STARTED
[15:41:35.914] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:37:0) after 3m47s
[15:45:22.979] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:37:0)
[15:45:23.025] Build status: STARTED
[15:45:23.025] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:38:0) after 1m14s
[15:46:37.083] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:38:0)
[15:46:37.100] Build status: STARTED
[15:46:37.100] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:39:0) after 5m52s
[15:52:29.115] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:39:0)
[15:52:29.138] Build status: STARTED
[15:52:29.138] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:40:0) after 2m8s
[15:54:37.155] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:40:0)
[15:54:37.173] Build status: STARTED
[15:54:37.173] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:41:0) after 8m48s
[16:03:25.479] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:41:0)
[16:03:25.496] Build status: STARTED
[16:03:25.496] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:42:0) after 5m9s
[16:08:34.556] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:42:0)
[16:08:34.574] Build status: STARTED
[16:08:34.574] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:43:0) after 5m59s
[16:14:33.826] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:43:0)
[16:14:33.841] Build status: STARTED
[16:14:33.841] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:44:0) after 1m57s
[16:16:30.856] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:44:0)
[16:16:30.885] Build status: STARTED
[16:16:30.885] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:45:0) after 6m54s
[16:23:25.082] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:45:0)
[16:23:25.098] Build status: STARTED
[16:23:25.098] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:46:0) after 9m38s
[16:33:03.101] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:46:0)
[16:33:03.136] Build status: STARTED
[16:33:03.136] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:47:0) after 3m48s
[16:36:51.185] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:47:0)
[16:36:51.217] Build status: STARTED
[16:36:51.217] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:48:0) after 2m47s
[16:39:38.570] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:48:0)
[16:39:38.587] Build status: STARTED
[16:39:38.587] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:49:0) after 6m30s
[16:46:08.635] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:49:0)
[16:46:08.671] Build status: STARTED
[16:46:08.671] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:50:0) after 4m54s
[16:51:02.804] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:50:0)
[16:51:02.885] Build status: STARTED
[16:51:02.885] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:51:0) after 2m15s
[16:53:17.901] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:51:0)
[16:53:17.921] Build status: STARTED
[16:53:17.921] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:52:0) after 7m38s
[17:00:56.023] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:52:0)
[17:00:56.088] Build status: STARTED
[17:00:56.088] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:53:0) after 8m50s
[17:09:46.203] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:53:0)
[17:09:46.225] Build status: STARTED
[17:09:46.225] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:54:0) after 4m21s
[17:14:07.242] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:54:0)
[17:14:07.261] Build status: STARTED
[17:14:07.261] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:55:0) after 1m46s
[17:15:53.378] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:55:0)
[17:15:53.438] Build status: STARTED
[17:15:53.438] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:56:0) after 5m25s
[17:21:18.464] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:56:0)
[17:21:18.496] Build status: STARTED
[17:21:18.496] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:57:0) after 5m21s
[17:26:39.716] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:57:0)
[17:26:39.741] Build status: STARTED
[17:26:39.741] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:58:0) after 8m23s
[17:35:02.756] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:58:0)
[17:35:02.779] Build status: STARTED
[17:35:02.779] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:59:0) after 9m35s
[17:44:37.974] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:59:0)
[17:44:37.989] Build status: STARTED
[17:44:37.990] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:60:0) after 7m40s
[17:52:18.013] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:60:0)
[17:52:18.028] Build status: STARTED
[17:52:18.028] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):8857765528145188592:61:0) after 8m58s
[17:56:30.709] Received PubSub notification, asking Buildbucket for the build status
[17:56:30.727] Build:
{
"id": "8692335466302831409",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Deterministic Linux (dbg)"
},
"number": 37598,
"createdBy": "project:chromium",
"createTime": "2026-01-18T12:38:58.407272484Z",
"startTime": "2026-01-18T12:39:03.408314855Z",
"endTime": "2026-01-18T17:56:30.390528007Z",
"updateTime": "2026-01-18T17:56:30.390528007Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "a3827d6816cb0480c9a0c9deb4df770e98020ee6",
"ref": "refs/heads/main"
}
}
}
[17:56:30.727] Invocation finished in 5h17m33.459565182s with status SUCCEEDED