[11:54:40.889] New invocation is queued and will start shortly
[11:54:42.052] Starting the invocation (attempt 1)
[11:54:42.096] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4418182fdfe57c6e579b05dd9c429b1e34aa0d61"
[11:54:42.096] Popped gitiles commit info from properties and tags
[11:54:42.097] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:54:42.097] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:54:42.097] Buildbucket request:
{
"requestId": "8951807964702449152",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64(dbg)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "4418182fdfe57c6e579b05dd9c429b1e34aa0d61",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8951807964702449152"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTWin64(dbg)"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[11:54:42.550] Scheduled build:
{
"id": "8786377902676333169",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64(dbg)"
},
"number": 10944,
"createdBy": "project:chromium",
"createTime": "2023-03-17T11:54:42.186572122Z",
"updateTime": "2023-03-17T11:54:42.186572122Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "4418182fdfe57c6e579b05dd9c429b1e34aa0d61",
"ref": "refs/heads/main"
}
}
}
[11:54:42.550] Task URL: https://cr-buildbucket.appspot.com/build/8786377902676333169
[11:54:42.550] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:2:0) after 5m25s
[11:59:41.789] Received PubSub notification, asking Buildbucket for the build status
[11:59:41.828] Build status: STARTED
[12:00:07.576] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:2:0)
[12:00:07.612] Build status: STARTED
[12:00:07.612] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:4:0) after 1m25s
[12:01:32.767] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:4:0)
[12:01:32.789] Build status: STARTED
[12:01:32.789] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:5:0) after 3m17s
[12:04:49.970] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:5:0)
[12:04:49.995] Build status: STARTED
[12:04:49.995] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:6:0) after 5m5s
[12:09:55.114] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:6:0)
[12:09:55.155] Build status: STARTED
[12:09:55.155] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:7:0) after 7m39s
[12:17:34.309] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:7:0)
[12:17:34.424] Build status: STARTED
[12:17:34.424] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:8:0) after 8m8s
[12:25:42.447] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:8:0)
[12:25:42.468] Build status: STARTED
[12:25:42.468] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:9:0) after 7m28s
[12:33:10.622] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:9:0)
[12:33:10.640] Build status: STARTED
[12:33:10.640] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:10:0) after 2m33s
[12:35:43.727] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:10:0)
[12:35:43.749] Build status: STARTED
[12:35:43.749] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:11:0) after 4m35s
[12:40:18.880] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:11:0)
[12:40:18.898] Build status: STARTED
[12:40:18.898] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:12:0) after 2m52s
[12:43:11.495] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:12:0)
[12:43:11.517] Build status: STARTED
[12:43:11.517] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:13:0) after 2m18s
[12:45:30.112] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:13:0)
[12:45:30.146] Build status: STARTED
[12:45:30.146] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:14:0) after 6m28s
[12:51:58.177] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:14:0)
[12:51:58.264] Build status: STARTED
[12:51:58.264] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:15:0) after 2m4s
[12:54:02.401] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:15:0)
[12:54:02.466] Build status: STARTED
[12:54:02.466] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:16:0) after 6m24s
[13:00:26.528] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:16:0)
[13:00:26.586] Build status: STARTED
[13:00:26.586] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:17:0) after 1m18s
[13:01:44.652] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:17:0)
[13:01:44.711] Build status: STARTED
[13:01:44.711] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:18:0) after 7m11s
[13:08:55.850] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:18:0)
[13:08:56.061] Build status: STARTED
[13:08:56.061] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:19:0) after 4m52s
[13:13:48.112] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:19:0)
[13:13:48.160] Build status: STARTED
[13:13:48.160] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:20:0) after 8m16s
[13:22:04.311] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:20:0)
[13:22:04.333] Build status: STARTED
[13:22:04.333] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:21:0) after 9m11s
[13:31:15.358] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:21:0)
[13:31:15.381] Build status: STARTED
[13:31:15.381] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:22:0) after 7m56s
[13:39:11.745] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:22:0)
[13:39:11.769] Build status: STARTED
[13:39:11.769] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:23:0) after 6m13s
[13:45:24.820] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:23:0)
[13:45:24.843] Build status: STARTED
[13:45:24.843] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:24:0) after 9m39s
[13:55:03.863] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:24:0)
[13:55:03.895] Build status: STARTED
[13:55:03.895] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:25:0) after 5m1s
[14:00:05.021] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:25:0)
[14:00:05.041] Build status: STARTED
[14:00:05.041] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:26:0) after 6m30s
[14:06:35.034] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:26:0)
[14:06:35.057] Build status: STARTED
[14:06:35.057] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:27:0) after 1m59s
[14:08:34.097] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:27:0)
[14:08:34.142] Build status: STARTED
[14:08:34.142] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:28:0) after 7m11s
[14:15:45.379] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:28:0)
[14:15:45.413] Build status: STARTED
[14:15:45.413] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:29:0) after 2m38s
[14:18:23.449] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:29:0)
[14:18:23.478] Build status: STARTED
[14:18:23.478] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:30:0) after 6m32s
[14:24:55.978] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:30:0)
[14:24:56.007] Build status: STARTED
[14:24:56.007] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:31:0) after 1m16s
[14:26:12.042] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:31:0)
[14:26:12.062] Build status: STARTED
[14:26:12.062] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:32:0) after 8m25s
[14:34:37.093] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:32:0)
[14:34:37.127] Build status: STARTED
[14:34:37.127] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:33:0) after 7m2s
[14:41:39.348] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:33:0)
[14:41:39.369] Build status: STARTED
[14:41:39.369] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:34:0) after 9m58s
[14:51:37.403] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:34:0)
[14:51:37.422] Build status: STARTED
[14:51:37.423] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:35:0) after 3m41s
[14:55:18.596] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:35:0)
[14:55:18.615] Build status: STARTED
[14:55:18.615] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:36:0) after 1m8s
[14:56:26.767] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:36:0)
[14:56:26.796] Build status: STARTED
[14:56:26.796] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:37:0) after 4m51s
[15:01:18.291] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:37:0)
[15:01:18.331] Build status: STARTED
[15:01:18.331] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:38:0) after 3m29s
[15:04:47.443] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:38:0)
[15:04:47.492] Build status: STARTED
[15:04:47.492] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:39:0) after 5m59s
[15:10:46.825] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:39:0)
[15:10:46.844] Build status: STARTED
[15:10:46.844] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:40:0) after 8m12s
[15:18:59.293] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:40:0)
[15:18:59.320] Build status: STARTED
[15:18:59.320] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:41:0) after 4m31s
[15:23:30.594] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:41:0)
[15:23:30.665] Build status: STARTED
[15:23:30.665] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:42:0) after 3m29s
[15:26:59.742] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:42:0)
[15:26:59.760] Build status: STARTED
[15:26:59.760] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:43:0) after 1m27s
[15:28:27.040] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:43:0)
[15:28:27.064] Build status: STARTED
[15:28:27.064] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:44:0) after 5m10s
[15:33:37.270] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:44:0)
[15:33:37.295] Build status: STARTED
[15:33:37.295] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:45:0) after 4m28s
[15:38:05.396] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:45:0)
[15:38:05.424] Build status: STARTED
[15:38:05.424] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:46:0) after 3m11s
[15:41:16.521] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:46:0)
[15:41:16.555] Build status: STARTED
[15:41:16.555] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:47:0) after 6m19s
[15:47:35.581] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:47:0)
[15:47:35.601] Build status: STARTED
[15:47:35.601] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:48:0) after 5m22s
[15:52:57.631] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:48:0)
[15:52:57.651] Build status: STARTED
[15:52:57.651] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:49:0) after 3m54s
[15:56:51.857] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:49:0)
[15:56:51.879] Build status: STARTED
[15:56:51.879] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:50:0) after 1m29s
[15:58:21.436] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:50:0)
[15:58:21.457] Build status: STARTED
[15:58:21.457] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:51:0) after 2m4s
[16:00:25.499] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:51:0)
[16:00:25.527] Build status: STARTED
[16:00:25.527] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:52:0) after 1m28s
[16:01:53.554] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:52:0)
[16:01:53.598] Build status: STARTED
[16:01:53.598] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:53:0) after 4m1s
[16:05:54.575] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:53:0)
[16:05:54.596] Build status: STARTED
[16:05:54.596] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:54:0) after 6m43s
[16:12:37.952] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:54:0)
[16:12:38.018] Build status: STARTED
[16:12:38.018] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:55:0) after 3m8s
[16:15:46.051] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:55:0)
[16:15:46.071] Build status: STARTED
[16:15:46.071] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:56:0) after 4m42s
[16:20:28.275] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:56:0)
[16:20:28.325] Build status: STARTED
[16:20:28.325] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:57:0) after 9m10s
[16:29:38.383] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:57:0)
[16:29:38.407] Build status: STARTED
[16:29:38.407] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:58:0) after 3m51s
[16:33:29.453] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:58:0)
[16:33:29.476] Build status: STARTED
[16:33:29.476] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:59:0) after 8m55s
[16:42:24.651] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:59:0)
[16:42:24.695] Build status: STARTED
[16:42:24.695] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:60:0) after 9m12s
[16:51:36.813] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:60:0)
[16:51:36.834] Build status: STARTED
[16:51:36.834] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:61:0) after 4m33s
[16:56:10.144] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:61:0)
[16:56:10.167] Build status: STARTED
[16:56:10.167] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:62:0) after 8m42s
[17:04:52.499] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:62:0)
[17:04:52.519] Build status: STARTED
[17:04:52.519] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:63:0) after 8m52s
[17:13:44.540] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:63:0)
[17:13:44.623] Build status: STARTED
[17:13:44.623] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:64:0) after 9m5s
[17:22:49.641] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:64:0)
[17:22:49.661] Build status: STARTED
[17:22:49.661] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:65:0) after 5m8s
[17:27:57.925] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:65:0)
[17:27:57.955] Build status: STARTED
[17:27:57.955] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:66:0) after 8m35s
[17:36:33.201] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:66:0)
[17:36:33.226] Build status: STARTED
[17:36:33.226] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:67:0) after 4m17s
[17:40:50.249] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:67:0)
[17:40:50.268] Build status: STARTED
[17:40:50.268] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:68:0) after 1m9s
[17:41:59.295] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:68:0)
[17:41:59.323] Build status: STARTED
[17:41:59.323] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:69:0) after 9m31s
[17:51:30.442] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:69:0)
[17:51:30.480] Build status: STARTED
[17:51:30.480] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:70:0) after 1m13s
[17:52:43.554] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:70:0)
[17:52:43.576] Build status: STARTED
[17:52:43.576] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:71:0) after 8m53s
[18:01:36.701] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:71:0)
[18:01:36.732] Build status: STARTED
[18:01:36.732] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:72:0) after 7m31s
[18:09:07.735] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:72:0)
[18:09:07.754] Build status: STARTED
[18:09:07.754] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:73:0) after 8m24s
[18:17:31.802] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:73:0)
[18:17:31.885] Build status: STARTED
[18:17:31.886] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:74:0) after 9m18s
[18:26:49.916] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:74:0)
[18:26:49.947] Build status: STARTED
[18:26:49.947] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:75:0) after 5m3s
[18:31:53.020] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:75:0)
[18:31:53.041] Build status: STARTED
[18:31:53.041] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:76:0) after 8m46s
[18:40:39.462] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:76:0)
[18:40:39.483] Build status: STARTED
[18:40:39.483] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:77:0) after 4m42s
[18:45:21.518] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:77:0)
[18:45:21.546] Build status: STARTED
[18:45:21.546] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:78:0) after 3m56s
[18:49:17.834] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:78:0)
[18:49:17.866] Build status: STARTED
[18:49:17.866] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:79:0) after 1m31s
[18:50:48.891] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:79:0)
[18:50:48.909] Build status: STARTED
[18:50:48.909] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:80:0) after 3m35s
[18:54:23.937] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:80:0)
[18:54:23.961] Build status: STARTED
[18:54:23.961] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:81:0) after 3m58s
[18:58:21.971] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:81:0)
[18:58:21.997] Build status: STARTED
[18:58:21.997] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:82:0) after 9m17s
[19:07:39.310] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:82:0)
[19:07:39.330] Build status: STARTED
[19:07:39.330] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:83:0) after 9m25s
[19:17:04.428] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:83:0)
[19:17:04.464] Build status: STARTED
[19:17:04.464] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:84:0) after 9m24s
[19:26:28.539] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:84:0)
[19:26:28.564] Build status: STARTED
[19:26:28.564] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:85:0) after 6m43s
[19:33:11.669] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:85:0)
[19:33:11.690] Build status: STARTED
[19:33:11.690] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:86:0) after 2m35s
[19:35:46.847] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:86:0)
[19:35:46.883] Build status: STARTED
[19:35:46.883] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:87:0) after 3m9s
[19:38:55.920] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:87:0)
[19:38:55.939] Build status: STARTED
[19:38:55.939] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:88:0) after 5m5s
[19:44:01.209] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:88:0)
[19:44:01.229] Build status: STARTED
[19:44:01.229] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:89:0) after 7m47s
[19:51:48.307] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:89:0)
[19:51:48.334] Build status: STARTED
[19:51:48.334] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:90:0) after 7m1s
[19:58:49.364] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:90:0)
[19:58:49.385] Build status: STARTED
[19:58:49.385] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:91:0) after 8m59s
[20:07:48.574] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:91:0)
[20:07:48.596] Build status: STARTED
[20:07:48.596] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:92:0) after 3m9s
[20:10:57.679] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:92:0)
[20:10:57.712] Build status: STARTED
[20:10:57.712] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:93:0) after 2m53s
[20:13:50.943] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:93:0)
[20:13:50.966] Build status: STARTED
[20:13:50.966] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:94:0) after 2m39s
[20:16:30.576] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:94:0)
[20:16:30.607] Build status: STARTED
[20:16:30.607] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:95:0) after 3m8s
[20:19:38.630] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:95:0)
[20:19:38.654] Build status: STARTED
[20:19:38.654] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:96:0) after 2m47s
[20:22:25.677] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:96:0)
[20:22:25.702] Build status: STARTED
[20:22:25.702] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:97:0) after 9m48s
[20:32:13.814] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:97:0)
[20:32:13.837] Build status: STARTED
[20:32:13.837] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:98:0) after 2m49s
[20:35:03.237] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:98:0)
[20:35:03.261] Build status: STARTED
[20:35:03.261] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:99:0) after 5m17s
[20:40:20.505] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:99:0)
[20:40:20.625] Build status: STARTED
[20:40:20.625] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:100:0) after 4m23s
[20:44:43.722] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:100:0)
[20:44:43.788] Build status: STARTED
[20:44:43.788] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:101:0) after 9m1s
[20:53:44.778] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:101:0)
[20:53:44.811] Build status: STARTED
[20:53:44.811] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:102:0) after 4m34s
[20:58:19.015] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:102:0)
[20:58:19.042] Build status: STARTED
[20:58:19.042] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:103:0) after 4m57s
[21:03:16.144] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:103:0)
[21:03:16.162] Build status: STARTED
[21:03:16.162] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:104:0) after 9m11s
[21:12:27.181] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:104:0)
[21:12:27.206] Build status: STARTED
[21:12:27.206] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:105:0) after 2m40s
[21:15:07.235] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:105:0)
[21:15:07.256] Build status: STARTED
[21:15:07.256] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:106:0) after 1m14s
[21:16:21.312] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:106:0)
[21:16:21.346] Build status: STARTED
[21:16:21.346] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:107:0) after 3m50s
[21:20:11.490] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:107:0)
[21:20:11.523] Build status: STARTED
[21:20:11.523] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:108:0) after 7m0s
[21:27:11.828] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:108:0)
[21:27:11.850] Build status: STARTED
[21:27:11.850] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:109:0) after 9m0s
[21:36:11.957] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:109:0)
[21:36:12.015] Build status: STARTED
[21:36:12.015] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:110:0) after 8m15s
[21:44:27.409] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:110:0)
[21:44:27.431] Build status: STARTED
[21:44:27.431] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:111:0) after 6m8s
[21:50:35.475] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:111:0)
[21:50:35.498] Build status: STARTED
[21:50:35.498] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:112:0) after 7m5s
[21:57:40.529] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:112:0)
[21:57:40.553] Build status: STARTED
[21:57:40.553] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:113:0) after 2m30s
[22:00:10.732] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:113:0)
[22:00:10.768] Build status: STARTED
[22:00:10.768] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:114:0) after 3m12s
[22:03:22.810] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:114:0)
[22:03:22.832] Build status: STARTED
[22:03:22.832] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:115:0) after 6m47s
[22:10:09.924] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:115:0)
[22:10:09.951] Build status: STARTED
[22:10:09.951] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:116:0) after 3m8s
[22:13:17.974] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:116:0)
[22:13:17.995] Build status: STARTED
[22:13:17.995] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:117:0) after 6m8s
[22:19:26.038] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:117:0)
[22:19:26.062] Build status: STARTED
[22:19:26.062] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:118:0) after 9m8s
[22:28:34.060] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:118:0)
[22:28:34.084] Build status: STARTED
[22:28:34.084] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:119:0) after 9m40s
[22:38:14.261] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:119:0)
[22:38:14.285] Build status: STARTED
[22:38:14.286] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64(dbg):8951807964702449152:120:0) after 3m25s
[22:41:31.997] Received PubSub notification, asking Buildbucket for the build status
[22:41:32.018] Build:
{
"id": "8786377902676333169",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64(dbg)"
},
"number": 10944,
"createdBy": "project:chromium",
"createTime": "2023-03-17T11:54:42.186572122Z",
"startTime": "2023-03-17T11:59:41.217214Z",
"endTime": "2023-03-17T22:41:31.657868446Z",
"updateTime": "2023-03-17T22:41:31.657868446Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "4418182fdfe57c6e579b05dd9c429b1e34aa0d61",
"ref": "refs/heads/main"
}
}
}
[22:41:32.018] Invocation finished in 10h46m51.147964158s with status FAILED