[02:27:30.603] New invocation is queued and will start shortly
[02:27:31.901] Starting the invocation (attempt 1)
[02:27:31.935] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ed173cf647dec873688f0209d0acaba70a7dea37"
[02:27:31.935] Popped gitiles commit info from properties and tags
[02:27:31.935] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:27:31.935] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:27:31.936] Buildbucket request:
{
"requestId": "8878460105256767056",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "ed173cf647dec873688f0209d0acaba70a7dea37",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8878460105256767056"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTWin(dbg)"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[02:27:32.500] Scheduled build:
{
"id": "8713030043067187553",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"number": 19282,
"createdBy": "project:chromium",
"createTime": "2025-06-04T02:27:32.058187344Z",
"updateTime": "2025-06-04T02:27:32.058187344Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "ed173cf647dec873688f0209d0acaba70a7dea37",
"ref": "refs/heads/main"
}
}
}
[02:27:32.500] Task URL: https://cr-buildbucket.appspot.com/build/8713030043067187553
[02:27:32.500] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:2:0) after 2m50s
[02:27:33.555] Received PubSub notification, asking Buildbucket for the build status
[02:27:33.580] Build status: SCHEDULED
[02:29:24.369] Received PubSub notification, asking Buildbucket for the build status
[02:29:24.383] Build status: STARTED
[02:30:22.533] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:2:0)
[02:30:22.562] Build status: STARTED
[02:30:22.562] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:5:0) after 8m24s
[02:38:46.591] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:5:0)
[02:38:46.610] Build status: STARTED
[02:38:46.610] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:6:0) after 5m16s
[02:44:02.647] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:6:0)
[02:44:02.674] Build status: STARTED
[02:44:02.674] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:7:0) after 8m40s
[02:52:42.719] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:7:0)
[02:52:42.746] Build status: STARTED
[02:52:42.746] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:8:0) after 8m59s
[03:01:41.791] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:8:0)
[03:01:41.807] Build status: STARTED
[03:01:41.807] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:9:0) after 7m57s
[03:09:38.912] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:9:0)
[03:09:38.938] Build status: STARTED
[03:09:38.938] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:10:0) after 3m21s
[03:12:59.968] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:10:0)
[03:13:00.006] Build status: STARTED
[03:13:00.006] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:11:0) after 9m44s
[03:22:44.037] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:11:0)
[03:22:44.102] Build status: STARTED
[03:22:44.102] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:12:0) after 6m56s
[03:29:40.177] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:12:0)
[03:29:40.204] Build status: STARTED
[03:29:40.204] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:13:0) after 6m53s
[03:36:33.497] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:13:0)
[03:36:33.550] Build status: STARTED
[03:36:33.551] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:14:0) after 8m2s
[03:44:35.685] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:14:0)
[03:44:35.726] Build status: STARTED
[03:44:35.726] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:15:0) after 4m29s
[03:49:06.773] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:15:0)
[03:49:06.797] Build status: STARTED
[03:49:06.797] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:16:0) after 3m54s
[03:53:01.130] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:16:0)
[03:53:01.150] Build status: STARTED
[03:53:01.150] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:17:0) after 7m45s
[04:00:46.192] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:17:0)
[04:00:46.247] Build status: STARTED
[04:00:46.247] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:18:0) after 1m11s
[04:01:57.307] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:18:0)
[04:01:57.342] Build status: STARTED
[04:01:57.342] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:19:0) after 4m44s
[04:06:41.427] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:19:0)
[04:06:41.498] Build status: STARTED
[04:06:41.498] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:20:0) after 4m40s
[04:11:21.574] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:20:0)
[04:11:21.596] Build status: STARTED
[04:11:21.596] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:21:0) after 7m30s
[04:18:51.715] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:21:0)
[04:18:51.735] Build status: STARTED
[04:18:51.736] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:22:0) after 8m57s
[04:27:48.901] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:22:0)
[04:27:48.917] Build status: STARTED
[04:27:48.917] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:23:0) after 7m52s
[04:35:41.166] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:23:0)
[04:35:41.199] Build status: STARTED
[04:35:41.199] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:24:0) after 7m18s
[04:42:59.281] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:24:0)
[04:42:59.300] Build status: STARTED
[04:42:59.300] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:25:0) after 1m50s
[04:44:49.648] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:25:0)
[04:44:49.669] Build status: STARTED
[04:44:49.670] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:26:0) after 9m41s
[04:54:30.721] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:26:0)
[04:54:30.743] Build status: STARTED
[04:54:30.743] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:27:0) after 3m41s
[04:58:11.778] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:27:0)
[04:58:11.812] Build status: STARTED
[04:58:11.812] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:28:0) after 7m12s
[05:05:23.855] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:28:0)
[05:05:23.937] Build status: STARTED
[05:05:23.937] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:29:0) after 5m53s
[05:11:17.026] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:29:0)
[05:11:17.043] Build status: STARTED
[05:11:17.043] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:30:0) after 6m26s
[05:17:43.152] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:30:0)
[05:17:43.204] Build status: STARTED
[05:17:43.204] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:31:0) after 9m38s
[05:27:21.250] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:31:0)
[05:27:21.270] Build status: STARTED
[05:27:21.270] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:32:0) after 5m13s
[05:32:34.297] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:32:0)
[05:32:34.368] Build status: STARTED
[05:32:34.368] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:33:0) after 7m35s
[05:40:09.459] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:33:0)
[05:40:09.478] Build status: STARTED
[05:40:09.478] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:34:0) after 7m32s
[05:47:41.626] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:34:0)
[05:47:41.645] Build status: STARTED
[05:47:41.645] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:35:0) after 1m43s
[05:49:24.722] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:35:0)
[05:49:24.738] Build status: STARTED
[05:49:24.738] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:36:0) after 2m25s
[05:51:49.764] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:36:0)
[05:51:49.782] Build status: STARTED
[05:51:49.783] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:37:0) after 7m39s
[05:59:28.861] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:37:0)
[05:59:28.875] Build status: STARTED
[05:59:28.875] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:38:0) after 5m29s
[06:04:58.635] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:38:0)
[06:04:58.666] Build status: STARTED
[06:04:58.666] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:39:0) after 9m51s
[06:14:49.714] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:39:0)
[06:14:49.735] Build status: STARTED
[06:14:49.735] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:40:0) after 5m0s
[06:19:49.853] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:40:0)
[06:19:49.899] Build status: STARTED
[06:19:49.899] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:41:0) after 7m4s
[06:26:53.905] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:41:0)
[06:26:53.930] Build status: STARTED
[06:26:53.930] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:42:0) after 6m30s
[06:33:23.964] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:42:0)
[06:33:23.978] Build status: STARTED
[06:33:23.978] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:43:0) after 2m56s
[06:36:20.007] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:43:0)
[06:36:20.025] Build status: STARTED
[06:36:20.025] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:44:0) after 3m9s
[06:39:29.045] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:44:0)
[06:39:29.104] Build status: STARTED
[06:39:29.104] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:45:0) after 9m34s
[06:49:03.246] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:45:0)
[06:49:03.262] Build status: STARTED
[06:49:03.262] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:46:0) after 9m14s
[06:58:17.298] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:46:0)
[06:58:17.338] Build status: STARTED
[06:58:17.338] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:47:0) after 9m26s
[07:07:43.439] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:47:0)
[07:07:43.511] Build status: STARTED
[07:07:43.511] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:48:0) after 1m43s
[07:09:26.592] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:48:0)
[07:09:26.651] Build status: STARTED
[07:09:26.651] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:49:0) after 7m34s
[07:17:01.243] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:49:0)
[07:17:01.414] Build status: STARTED
[07:17:01.414] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:50:0) after 2m18s
[07:19:19.447] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:50:0)
[07:19:19.469] Build status: STARTED
[07:19:19.469] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:51:0) after 3m23s
[07:22:42.479] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:51:0)
[07:22:42.495] Build status: STARTED
[07:22:42.495] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:52:0) after 5m20s
[07:28:02.543] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:52:0)
[07:28:02.561] Build status: STARTED
[07:28:02.561] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:53:0) after 8m48s
[07:36:50.582] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:53:0)
[07:36:50.605] Build status: STARTED
[07:36:50.605] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:54:0) after 3m7s
[07:39:57.615] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:54:0)
[07:39:57.657] Build status: STARTED
[07:39:57.657] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:55:0) after 9m1s
[07:48:58.678] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:55:0)
[07:48:58.697] Build status: STARTED
[07:48:58.697] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:56:0) after 6m8s
[07:55:06.726] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:56:0)
[07:55:06.749] Build status: STARTED
[07:55:06.750] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:57:0) after 8m53s
[08:03:59.817] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:57:0)
[08:03:59.915] Build status: STARTED
[08:03:59.915] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:58:0) after 9m36s
[08:13:35.962] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:58:0)
[08:13:36.007] Build status: STARTED
[08:13:36.007] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:59:0) after 6m3s
[08:19:39.476] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:59:0)
[08:19:39.499] Build status: STARTED
[08:19:39.499] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:60:0) after 7m24s
[08:27:03.547] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:60:0)
[08:27:03.565] Build status: STARTED
[08:27:03.614] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:61:0) after 1m39s
[08:28:42.651] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:61:0)
[08:28:42.668] Build status: STARTED
[08:28:42.668] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:62:0) after 6m47s
[08:35:29.704] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:62:0)
[08:35:29.747] Build status: STARTED
[08:35:29.747] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:63:0) after 7m40s
[08:43:09.786] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:63:0)
[08:43:09.824] Build status: STARTED
[08:43:09.824] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:64:0) after 1m48s
[08:44:57.836] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:64:0)
[08:44:57.860] Build status: STARTED
[08:44:57.860] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:65:0) after 5m21s
[08:50:18.943] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:65:0)
[08:50:18.984] Build status: STARTED
[08:50:18.984] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:66:0) after 7m39s
[08:57:58.021] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:66:0)
[08:57:58.048] Build status: STARTED
[08:57:58.048] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:67:0) after 9m45s
[09:07:43.138] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:67:0)
[09:07:43.152] Build status: STARTED
[09:07:43.153] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:68:0) after 8m3s
[09:15:46.208] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:68:0)
[09:15:46.226] Build status: STARTED
[09:15:46.226] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:69:0) after 7m36s
[09:23:22.367] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:69:0)
[09:23:22.398] Build status: STARTED
[09:23:22.398] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:70:0) after 8m20s
[09:31:42.486] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:70:0)
[09:31:42.521] Build status: STARTED
[09:31:42.522] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:71:0) after 3m47s
[09:35:30.161] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:71:0)
[09:35:30.182] Build status: STARTED
[09:35:30.182] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:72:0) after 3m24s
[09:38:54.209] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:72:0)
[09:38:54.226] Build status: STARTED
[09:38:54.226] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:73:0) after 8m14s
[09:47:08.257] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:73:0)
[09:47:08.275] Build status: STARTED
[09:47:08.275] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:74:0) after 9m40s
[09:56:48.384] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:74:0)
[09:56:48.401] Build status: STARTED
[09:56:48.401] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:75:0) after 9m30s
[10:06:18.639] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:75:0)
[10:06:18.655] Build status: STARTED
[10:06:18.655] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:76:0) after 3m5s
[10:09:23.901] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:76:0)
[10:09:23.923] Build status: STARTED
[10:09:23.923] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:77:0) after 2m21s
[10:11:45.307] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:77:0)
[10:11:45.337] Build status: STARTED
[10:11:45.337] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:78:0) after 3m15s
[10:15:00.375] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:78:0)
[10:15:00.404] Build status: STARTED
[10:15:00.404] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:79:0) after 2m26s
[10:17:26.445] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:79:0)
[10:17:26.477] Build status: STARTED
[10:17:26.477] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:80:0) after 8m8s
[10:25:34.512] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:80:0)
[10:25:34.526] Build status: STARTED
[10:25:34.526] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:81:0) after 2m11s
[10:27:45.553] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:81:0)
[10:27:45.573] Build status: STARTED
[10:27:45.573] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:82:0) after 1m33s
[10:29:18.609] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:82:0)
[10:29:18.688] Build status: STARTED
[10:29:18.688] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:83:0) after 2m59s
[10:32:17.725] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:83:0)
[10:32:17.743] Build status: STARTED
[10:32:17.743] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:84:0) after 1m36s
[10:33:53.779] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:84:0)
[10:33:53.919] Build status: STARTED
[10:33:53.919] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:85:0) after 7m58s
[10:41:51.976] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:85:0)
[10:41:51.991] Build status: STARTED
[10:41:51.991] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:86:0) after 3m13s
[10:45:05.059] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:86:0)
[10:45:05.077] Build status: STARTED
[10:45:05.077] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:87:0) after 5m19s
[10:50:24.109] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:87:0)
[10:50:24.138] Build status: STARTED
[10:50:24.138] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:88:0) after 3m40s
[10:54:04.186] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:88:0)
[10:54:04.213] Build status: STARTED
[10:54:04.213] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:89:0) after 7m4s
[11:01:08.242] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:89:0)
[11:01:08.260] Build status: STARTED
[11:01:08.260] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:90:0) after 6m6s
[11:07:14.459] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:90:0)
[11:07:14.477] Build status: STARTED
[11:07:14.477] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:91:0) after 5m13s
[11:12:27.994] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:91:0)
[11:12:28.134] Build status: STARTED
[11:12:28.134] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:92:0) after 7m40s
[11:20:08.885] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:92:0)
[11:20:08.900] Build status: STARTED
[11:20:08.900] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:93:0) after 7m53s
[11:28:01.949] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:93:0)
[11:28:01.967] Build status: STARTED
[11:28:01.967] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:94:0) after 2m33s
[11:30:35.065] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:94:0)
[11:30:35.131] Build status: STARTED
[11:30:35.131] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:95:0) after 1m51s
[11:32:26.287] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:95:0)
[11:32:26.312] Build status: STARTED
[11:32:26.312] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:96:0) after 8m1s
[11:40:27.741] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:96:0)
[11:40:27.768] Build status: STARTED
[11:40:27.768] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:97:0) after 2m40s
[11:43:08.056] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:97:0)
[11:43:08.073] Build status: STARTED
[11:43:08.073] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:98:0) after 6m15s
[11:49:23.437] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:98:0)
[11:49:23.467] Build status: STARTED
[11:49:23.467] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:99:0) after 4m23s
[11:53:46.532] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:99:0)
[11:53:46.548] Build status: STARTED
[11:53:46.548] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:100:0) after 6m39s
[12:00:25.945] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:100:0)
[12:00:25.961] Build status: STARTED
[12:00:25.961] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:101:0) after 5m53s
[12:06:19.128] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:101:0)
[12:06:19.146] Build status: STARTED
[12:06:19.146] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:102:0) after 2m48s
[12:09:07.184] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:102:0)
[12:09:07.216] Build status: STARTED
[12:09:07.216] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:103:0) after 7m7s
[12:16:14.619] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:103:0)
[12:16:14.642] Build status: STARTED
[12:16:14.642] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:104:0) after 2m48s
[12:19:03.138] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:104:0)
[12:19:03.162] Build status: STARTED
[12:19:03.162] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:105:0) after 8m4s
[12:27:07.284] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:105:0)
[12:27:07.335] Build status: STARTED
[12:27:07.335] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:106:0) after 4m9s
[12:31:16.368] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:106:0)
[12:31:16.385] Build status: STARTED
[12:31:16.385] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:107:0) after 8m54s
[12:40:10.419] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:107:0)
[12:40:10.489] Build status: STARTED
[12:40:10.489] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:108:0) after 6m36s
[12:46:46.771] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:108:0)
[12:46:46.786] Build status: STARTED
[12:46:46.787] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:109:0) after 3m22s
[12:50:08.844] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:109:0)
[12:50:08.872] Build status: STARTED
[12:50:08.872] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:110:0) after 3m13s
[12:53:22.037] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:110:0)
[12:53:22.067] Build status: STARTED
[12:53:22.067] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:111:0) after 6m20s
[12:59:42.175] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:111:0)
[12:59:42.212] Build status: STARTED
[12:59:42.212] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:112:0) after 6m51s
[13:06:33.891] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:112:0)
[13:06:33.917] Build status: STARTED
[13:06:33.917] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:113:0) after 3m2s
[13:09:35.999] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:113:0)
[13:09:36.021] Build status: STARTED
[13:09:36.021] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:114:0) after 2m20s
[13:11:56.092] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:114:0)
[13:11:56.112] Build status: STARTED
[13:11:56.112] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:115:0) after 7m21s
[13:19:17.157] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:115:0)
[13:19:17.171] Build status: STARTED
[13:19:17.171] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:116:0) after 1m11s
[13:20:28.255] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:116:0)
[13:20:28.271] Build status: STARTED
[13:20:28.271] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:117:0) after 5m58s
[13:26:26.361] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:117:0)
[13:26:26.431] Build status: STARTED
[13:26:26.431] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:118:0) after 7m52s
[13:34:18.529] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:118:0)
[13:34:18.553] Build status: STARTED
[13:34:18.553] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:119:0) after 4m26s
[13:38:44.617] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:119:0)
[13:38:44.639] Build status: STARTED
[13:38:44.640] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:120:0) after 4m0s
[13:42:44.685] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:120:0)
[13:42:44.709] Build status: STARTED
[13:42:44.709] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:121:0) after 7m10s
[13:49:54.806] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:121:0)
[13:49:54.829] Build status: STARTED
[13:49:54.829] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:122:0) after 8m4s
[13:57:59.270] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:122:0)
[13:57:59.287] Build status: STARTED
[13:57:59.287] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:123:0) after 5m27s
[14:03:26.780] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:123:0)
[14:03:26.799] Build status: STARTED
[14:03:26.799] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:124:0) after 5m59s
[14:09:25.894] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:124:0)
[14:09:25.944] Build status: STARTED
[14:09:25.944] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:125:0) after 8m12s
[14:17:38.177] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:125:0)
[14:17:38.197] Build status: STARTED
[14:17:38.197] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:126:0) after 6m36s
[14:24:14.336] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:126:0)
[14:24:14.393] Build status: STARTED
[14:24:14.393] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:127:0) after 5m31s
[14:29:45.433] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:127:0)
[14:29:45.453] Build status: STARTED
[14:29:45.453] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8878460105256767056:128:0) after 9m53s
[14:38:23.813] Received PubSub notification, asking Buildbucket for the build status
[14:38:23.840] Build:
{
"id": "8713030043067187553",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"number": 19282,
"createdBy": "project:chromium",
"createTime": "2025-06-04T02:27:32.058187344Z",
"startTime": "2025-06-04T02:29:24.169121280Z",
"endTime": "2025-06-04T14:38:23.516577089Z",
"updateTime": "2025-06-04T14:38:23.516577089Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "ed173cf647dec873688f0209d0acaba70a7dea37",
"ref": "refs/heads/main"
}
}
}
[14:38:23.840] Invocation finished in 12h10m53.253371798s with status SUCCEEDED