[19:25:27.524] New invocation is queued and will start shortly
[19:25:28.582] Starting the invocation (attempt 1)
[19:25:28.606] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/438a1bc371f24977c0047cb574bd9c72853711c0"
[19:25:28.606] Popped gitiles commit info from properties and tags
[19:25:28.606] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:25:28.606] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:25:28.606] Buildbucket request:
{
"requestId": "8893253963948875184",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "438a1bc371f24977c0047cb574bd9c72853711c0",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8893253963948875184"
},
{
"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"
}
}
[19:25:29.097] Scheduled build:
{
"id": "8727823902090468529",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"number": 17718,
"createdBy": "project:chromium",
"createTime": "2024-12-22T19:25:28.667662087Z",
"updateTime": "2024-12-22T19:25:28.667662087Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "438a1bc371f24977c0047cb574bd9c72853711c0",
"ref": "refs/heads/main"
}
}
}
[19:25:29.097] Task URL: https://cr-buildbucket.appspot.com/build/8727823902090468529
[19:25:29.097] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:2:0) after 8m35s
[19:25:30.145] Received PubSub notification, asking Buildbucket for the build status
[19:25:30.166] Build status: SCHEDULED
[19:31:35.042] Received PubSub notification, asking Buildbucket for the build status
[19:31:35.065] Build status: STARTED
[19:34:04.404] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:2:0)
[19:34:04.420] Build status: STARTED
[19:34:04.420] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:5:0) after 5m31s
[19:39:35.439] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:5:0)
[19:39:35.464] Build status: STARTED
[19:39:35.464] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:6:0) after 8m33s
[19:48:08.480] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:6:0)
[19:48:08.506] Build status: STARTED
[19:48:08.506] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:7:0) after 1m12s
[19:49:20.522] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:7:0)
[19:49:20.568] Build status: STARTED
[19:49:20.568] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:8:0) after 8m28s
[19:57:48.911] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:8:0)
[19:57:48.932] Build status: STARTED
[19:57:48.932] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:9:0) after 2m9s
[19:59:57.959] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:9:0)
[19:59:57.978] Build status: STARTED
[19:59:57.978] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:10:0) after 2m23s
[20:02:21.118] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:10:0)
[20:02:21.146] Build status: STARTED
[20:02:21.146] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:11:0) after 1m36s
[20:03:57.206] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:11:0)
[20:03:57.235] Build status: STARTED
[20:03:57.235] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:12:0) after 9m7s
[20:13:04.386] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:12:0)
[20:13:04.401] Build status: STARTED
[20:13:04.401] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:13:0) after 5m40s
[20:18:44.452] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:13:0)
[20:18:44.478] Build status: STARTED
[20:18:44.478] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:14:0) after 5m7s
[20:23:51.526] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:14:0)
[20:23:51.548] Build status: STARTED
[20:23:51.548] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:15:0) after 1m21s
[20:25:12.567] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:15:0)
[20:25:12.596] Build status: STARTED
[20:25:12.596] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:16:0) after 5m4s
[20:30:16.623] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:16:0)
[20:30:16.662] Build status: STARTED
[20:30:16.662] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:17:0) after 9m36s
[20:39:52.823] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:17:0)
[20:39:52.869] Build status: STARTED
[20:39:52.869] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:18:0) after 3m28s
[20:43:20.913] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:18:0)
[20:43:20.938] Build status: STARTED
[20:43:20.939] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:19:0) after 3m36s
[20:46:56.964] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:19:0)
[20:46:56.989] Build status: STARTED
[20:46:56.989] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:20:0) after 5m31s
[20:52:28.291] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:20:0)
[20:52:28.315] Build status: STARTED
[20:52:28.315] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:21:0) after 4m29s
[20:56:57.506] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:21:0)
[20:56:57.532] Build status: STARTED
[20:56:57.532] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:22:0) after 7m34s
[21:04:31.641] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:22:0)
[21:04:31.662] Build status: STARTED
[21:04:31.662] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:23:0) after 9m21s
[21:13:52.684] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:23:0)
[21:13:52.770] Build status: STARTED
[21:13:52.770] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:24:0) after 3m52s
[21:17:44.960] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:24:0)
[21:17:45.047] Build status: STARTED
[21:17:45.047] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:25:0) after 8m41s
[21:26:26.189] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:25:0)
[21:26:26.206] Build status: STARTED
[21:26:26.206] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:26:0) after 1m40s
[21:28:06.377] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:26:0)
[21:28:06.476] Build status: STARTED
[21:28:06.476] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:27:0) after 9m29s
[21:37:35.583] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:27:0)
[21:37:35.602] Build status: STARTED
[21:37:35.602] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:28:0) after 6m54s
[21:44:29.621] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:28:0)
[21:44:29.654] Build status: STARTED
[21:44:29.654] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:29:0) after 6m37s
[21:51:06.915] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:29:0)
[21:51:06.933] Build status: STARTED
[21:51:06.933] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:30:0) after 4m16s
[21:55:23.026] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:30:0)
[21:55:23.055] Build status: STARTED
[21:55:23.055] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:31:0) after 5m49s
[22:01:12.084] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:31:0)
[22:01:12.176] Build status: STARTED
[22:01:12.176] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:32:0) after 1m35s
[22:02:47.251] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:32:0)
[22:02:47.284] Build status: STARTED
[22:02:47.284] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:33:0) after 3m4s
[22:05:51.331] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:33:0)
[22:05:51.350] Build status: STARTED
[22:05:51.350] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:34:0) after 6m24s
[22:12:15.438] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:34:0)
[22:12:15.455] Build status: STARTED
[22:12:15.455] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:35:0) after 9m10s
[22:21:25.482] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:35:0)
[22:21:25.499] Build status: STARTED
[22:21:25.499] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:36:0) after 7m3s
[22:28:28.551] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:36:0)
[22:28:28.576] Build status: STARTED
[22:28:28.576] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:37:0) after 3m47s
[22:32:15.737] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:37:0)
[22:32:15.792] Build status: STARTED
[22:32:15.792] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:38:0) after 7m27s
[22:39:42.811] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:38:0)
[22:39:42.832] Build status: STARTED
[22:39:42.832] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:39:0) after 6m58s
[22:46:40.914] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:39:0)
[22:46:40.930] Build status: STARTED
[22:46:40.930] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:40:0) after 1m29s
[22:48:10.164] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:40:0)
[22:48:10.181] Build status: STARTED
[22:48:10.181] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:41:0) after 8m34s
[22:56:44.206] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:41:0)
[22:56:44.222] Build status: STARTED
[22:56:44.222] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:42:0) after 9m30s
[23:06:14.372] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:42:0)
[23:06:14.392] Build status: STARTED
[23:06:14.392] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:43:0) after 9m16s
[23:15:30.607] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:43:0)
[23:15:30.631] Build status: STARTED
[23:15:30.631] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:44:0) after 8m47s
[23:24:17.724] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:44:0)
[23:24:17.741] Build status: STARTED
[23:24:17.741] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:45:0) after 5m11s
[23:29:28.790] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:45:0)
[23:29:28.835] Build status: STARTED
[23:29:28.835] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:46:0) after 8m3s
[23:37:31.866] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:46:0)
[23:37:31.887] Build status: STARTED
[23:37:31.887] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:47:0) after 1m42s
[23:39:14.044] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:47:0)
[23:39:14.075] Build status: STARTED
[23:39:14.075] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:48:0) after 6m58s
[23:46:12.054] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:48:0)
[23:46:12.074] Build status: STARTED
[23:46:12.074] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:49:0) after 1m20s
[23:47:32.091] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:49:0)
[23:47:32.109] Build status: STARTED
[23:47:32.109] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:50:0) after 1m56s
[23:49:28.134] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:50:0)
[23:49:28.186] Build status: STARTED
[23:49:28.186] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:51:0) after 7m8s
[23:56:36.281] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:51:0)
[23:56:36.301] Build status: STARTED
[23:56:36.302] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:52:0) after 8m4s
[00:04:40.332] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:52:0)
[00:04:40.359] Build status: STARTED
[00:04:40.359] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:53:0) after 4m36s
[00:09:16.482] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:53:0)
[00:09:16.505] Build status: STARTED
[00:09:16.505] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:54:0) after 5m37s
[00:14:53.853] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:54:0)
[00:14:53.874] Build status: STARTED
[00:14:53.874] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:55:0) after 4m50s
[00:19:44.334] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:55:0)
[00:19:44.355] Build status: STARTED
[00:19:44.355] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:56:0) after 8m33s
[00:28:17.390] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:56:0)
[00:28:17.416] Build status: STARTED
[00:28:17.416] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:57:0) after 8m37s
[00:36:54.495] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:57:0)
[00:36:54.516] Build status: STARTED
[00:36:54.516] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:58:0) after 4m17s
[00:41:11.543] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:58:0)
[00:41:11.562] Build status: STARTED
[00:41:11.562] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:59:0) after 1m18s
[00:42:29.582] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:59:0)
[00:42:29.600] Build status: STARTED
[00:42:29.600] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:60:0) after 3m27s
[00:45:56.689] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:60:0)
[00:45:56.703] Build status: STARTED
[00:45:56.703] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:61:0) after 1m29s
[00:47:25.944] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:61:0)
[00:47:25.974] Build status: STARTED
[00:47:25.974] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:62:0) after 2m8s
[00:49:34.021] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:62:0)
[00:49:34.038] Build status: STARTED
[00:49:34.038] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:63:0) after 1m55s
[00:51:29.087] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:63:0)
[00:51:29.125] Build status: STARTED
[00:51:29.125] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:64:0) after 8m54s
[01:00:23.207] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:64:0)
[01:00:23.229] Build status: STARTED
[01:00:23.229] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:65:0) after 6m20s
[01:06:43.387] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:65:0)
[01:06:43.413] Build status: STARTED
[01:06:43.413] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:66:0) after 1m35s
[01:08:18.428] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:66:0)
[01:08:18.444] Build status: STARTED
[01:08:18.444] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:67:0) after 7m45s
[01:16:03.463] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:67:0)
[01:16:03.531] Build status: STARTED
[01:16:03.531] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:68:0) after 9m55s
[01:25:58.790] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:68:0)
[01:25:58.810] Build status: STARTED
[01:25:58.810] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:69:0) after 5m50s
[01:31:49.274] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:69:0)
[01:31:49.296] Build status: STARTED
[01:31:49.296] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:70:0) after 2m30s
[01:34:19.314] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:70:0)
[01:34:19.389] Build status: STARTED
[01:34:19.389] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:71:0) after 7m14s
[01:41:33.405] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:71:0)
[01:41:33.421] Build status: STARTED
[01:41:33.421] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:72:0) after 6m11s
[01:47:44.448] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:72:0)
[01:47:44.462] Build status: STARTED
[01:47:44.462] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:73:0) after 9m21s
[01:57:05.596] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:73:0)
[01:57:05.615] Build status: STARTED
[01:57:05.615] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:74:0) after 5m3s
[02:02:08.659] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:74:0)
[02:02:08.688] Build status: STARTED
[02:02:08.688] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:75:0) after 8m5s
[02:10:13.795] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:75:0)
[02:10:13.823] Build status: STARTED
[02:10:13.823] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:76:0) after 8m33s
[02:18:46.840] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:76:0)
[02:18:46.856] Build status: STARTED
[02:18:46.856] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:77:0) after 1m39s
[02:20:25.880] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:77:0)
[02:20:25.915] Build status: STARTED
[02:20:25.915] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:78:0) after 5m27s
[02:25:52.941] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:78:0)
[02:25:52.955] Build status: STARTED
[02:25:52.955] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:79:0) after 1m33s
[02:27:26.180] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:79:0)
[02:27:26.199] Build status: STARTED
[02:27:26.199] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:80:0) after 5m16s
[02:32:42.234] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:80:0)
[02:32:42.279] Build status: STARTED
[02:32:42.279] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:81:0) after 4m17s
[02:36:59.318] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:81:0)
[02:36:59.335] Build status: STARTED
[02:36:59.335] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:82:0) after 8m58s
[02:45:57.560] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:82:0)
[02:45:57.583] Build status: STARTED
[02:45:57.583] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:83:0) after 6m59s
[02:52:56.611] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:83:0)
[02:52:56.630] Build status: STARTED
[02:52:56.630] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:84:0) after 6m25s
[02:59:21.657] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:84:0)
[02:59:21.674] Build status: STARTED
[02:59:21.674] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:85:0) after 7m37s
[03:06:58.693] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:85:0)
[03:06:58.715] Build status: STARTED
[03:06:58.715] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:86:0) after 5m26s
[03:12:24.744] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:86:0)
[03:12:24.761] Build status: STARTED
[03:12:24.761] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:87:0) after 1m40s
[03:14:04.785] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:87:0)
[03:14:04.807] Build status: STARTED
[03:14:04.807] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:88:0) after 9m16s
[03:23:20.830] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:88:0)
[03:23:20.850] Build status: STARTED
[03:23:20.850] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:89:0) after 6m26s
[03:29:46.983] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:89:0)
[03:29:47.009] Build status: STARTED
[03:29:47.009] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:90:0) after 3m48s
[03:33:35.040] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:90:0)
[03:33:35.068] Build status: STARTED
[03:33:35.068] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:91:0) after 1m50s
[03:35:25.119] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:91:0)
[03:35:25.155] Build status: STARTED
[03:35:25.155] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:92:0) after 4m48s
[03:40:13.245] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:92:0)
[03:40:13.262] Build status: STARTED
[03:40:13.262] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:93:0) after 3m43s
[03:43:56.284] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:93:0)
[03:43:56.299] Build status: STARTED
[03:43:56.299] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:94:0) after 3m37s
[03:47:33.327] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:94:0)
[03:47:33.344] Build status: STARTED
[03:47:33.344] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:95:0) after 4m56s
[03:52:29.558] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:95:0)
[03:52:29.610] Build status: STARTED
[03:52:29.610] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:96:0) after 1m11s
[03:53:40.636] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:96:0)
[03:53:40.658] Build status: STARTED
[03:53:40.658] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:97:0) after 8m45s
[04:02:25.740] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:97:0)
[04:02:25.785] Build status: STARTED
[04:02:25.785] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:98:0) after 2m29s
[04:04:54.992] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:98:0)
[04:04:55.096] Build status: STARTED
[04:04:55.096] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:99:0) after 4m5s
[04:09:00.211] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:99:0)
[04:09:00.230] Build status: STARTED
[04:09:00.230] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:100:0) after 4m41s
[04:13:41.309] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:100:0)
[04:13:41.375] Build status: STARTED
[04:13:41.375] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:101:0) after 7m8s
[04:20:49.549] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:101:0)
[04:20:49.571] Build status: STARTED
[04:20:49.571] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:102:0) after 4m8s
[04:24:57.745] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:102:0)
[04:24:57.770] Build status: STARTED
[04:24:57.770] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:103:0) after 3m33s
[04:28:30.819] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:103:0)
[04:28:30.837] Build status: STARTED
[04:28:30.837] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:104:0) after 2m7s
[04:30:37.862] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:104:0)
[04:30:37.884] Build status: STARTED
[04:30:37.884] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:105:0) after 7m3s
[04:37:40.932] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:105:0)
[04:37:40.949] Build status: STARTED
[04:37:40.949] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:106:0) after 1m2s
[04:38:43.043] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:106:0)
[04:38:43.067] Build status: STARTED
[04:38:43.067] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:107:0) after 6m35s
[04:45:18.061] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:107:0)
[04:45:18.093] Build status: STARTED
[04:45:18.093] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:108:0) after 9m8s
[04:54:26.133] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:108:0)
[04:54:26.147] Build status: STARTED
[04:54:26.147] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:109:0) after 2m23s
[04:56:49.174] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:109:0)
[04:56:49.190] Build status: STARTED
[04:56:49.190] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:110:0) after 1m9s
[04:57:58.219] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:110:0)
[04:57:58.238] Build status: STARTED
[04:57:58.239] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:111:0) after 2m40s
[05:00:38.261] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:111:0)
[05:00:38.284] Build status: STARTED
[05:00:38.284] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:112:0) after 5m6s
[05:05:44.308] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:112:0)
[05:05:44.328] Build status: STARTED
[05:05:44.328] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:113:0) after 3m54s
[05:09:38.349] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:113:0)
[05:09:38.365] Build status: STARTED
[05:09:38.365] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:114:0) after 2m2s
[05:11:40.402] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:114:0)
[05:11:40.421] Build status: STARTED
[05:11:40.421] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:115:0) after 1m16s
[05:12:56.503] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:115:0)
[05:12:56.526] Build status: STARTED
[05:12:56.526] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:116:0) after 9m48s
[05:22:44.690] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:116:0)
[05:22:44.713] Build status: STARTED
[05:22:44.713] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:117:0) after 1m47s
[05:24:31.730] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:117:0)
[05:24:31.810] Build status: STARTED
[05:24:31.810] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:118:0) after 5m48s
[05:30:19.857] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:118:0)
[05:30:19.874] Build status: STARTED
[05:30:19.874] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:119:0) after 3m11s
[05:33:30.950] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:119:0)
[05:33:30.966] Build status: STARTED
[05:33:30.966] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:120:0) after 1m58s
[05:35:29.024] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:120:0)
[05:35:29.103] Build status: STARTED
[05:35:29.103] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:121:0) after 4m45s
[05:40:14.122] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:121:0)
[05:40:14.143] Build status: STARTED
[05:40:14.143] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:122:0) after 2m33s
[05:42:47.351] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:122:0)
[05:42:47.367] Build status: STARTED
[05:42:47.367] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:123:0) after 8m45s
[05:51:32.455] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:123:0)
[05:51:32.471] Build status: STARTED
[05:51:32.471] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:124:0) after 3m5s
[05:54:37.513] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:124:0)
[05:54:37.528] Build status: STARTED
[05:54:37.528] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:125:0) after 4m17s
[05:58:54.560] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:125:0)
[05:58:54.581] Build status: STARTED
[05:58:54.582] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:126:0) after 2m57s
[06:01:51.635] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:126:0)
[06:01:51.668] Build status: STARTED
[06:01:51.668] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:127:0) after 7m21s
[06:09:12.694] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:127:0)
[06:09:12.714] Build status: STARTED
[06:09:12.714] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:128:0) after 8m11s
[06:17:23.834] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:128:0)
[06:17:23.858] Build status: STARTED
[06:17:23.858] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:129:0) after 2m8s
[06:19:31.989] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:129:0)
[06:19:32.006] Build status: STARTED
[06:19:32.006] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:130:0) after 8m49s
[06:28:21.080] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:130:0)
[06:28:21.099] Build status: STARTED
[06:28:21.099] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:131:0) after 2m8s
[06:30:29.137] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:131:0)
[06:30:29.153] Build status: STARTED
[06:30:29.153] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:132:0) after 3m38s
[06:34:07.170] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:132:0)
[06:34:07.185] Build status: STARTED
[06:34:07.185] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:133:0) after 7m56s
[06:42:03.213] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:133:0)
[06:42:03.230] Build status: STARTED
[06:42:03.230] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:134:0) after 5m36s
[06:47:39.244] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:134:0)
[06:47:39.262] Build status: STARTED
[06:47:39.262] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:135:0) after 8m16s
[06:55:55.324] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:135:0)
[06:55:55.344] Build status: STARTED
[06:55:55.344] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8893253963948875184:136:0) after 8m25s
[07:01:44.486] Received PubSub notification, asking Buildbucket for the build status
[07:01:44.535] Build:
{
"id": "8727823902090468529",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"number": 17718,
"createdBy": "project:chromium",
"createTime": "2024-12-22T19:25:28.667662087Z",
"startTime": "2024-12-22T19:31:34.770637254Z",
"endTime": "2024-12-23T07:01:44.005235715Z",
"updateTime": "2024-12-23T07:01:44.005235715Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "438a1bc371f24977c0047cb574bd9c72853711c0",
"ref": "refs/heads/main"
}
}
}
[07:01:44.535] Invocation finished in 11h36m17.02391576s with status SUCCEEDED