[10:57:30.029] New invocation is queued and will start shortly
[10:57:31.342] Starting the invocation (attempt 1)
[10:57:31.372] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8d43cc12aae5a4421b5c864ecc489500ab4e0faf"
[10:57:31.372] Popped gitiles commit info from properties and tags
[10:57:31.372] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:57:31.372] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:57:31.372] Buildbucket request:
{
"requestId": "8931155453871780864",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "fuchsia-fyi-x64-asan"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "8d43cc12aae5a4421b5c864ecc489500ab4e0faf",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8931155453871780864"
},
{
"key": "scheduler_job_id",
"value": "chromium/fuchsia-fyi-x64-asan"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[10:57:32.485] Scheduled build:
{
"id": "8765725391705634145",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "fuchsia-fyi-x64-asan"
},
"number": 4507,
"createdBy": "project:chromium",
"createTime": "2023-10-31T10:57:31.468843874Z",
"updateTime": "2023-10-31T10:57:31.468843874Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "8d43cc12aae5a4421b5c864ecc489500ab4e0faf",
"ref": "refs/heads/main"
}
}
}
[10:57:32.485] Task URL: https://cr-buildbucket.appspot.com/build/8765725391705634145
[10:57:32.485] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:2:0) after 2m18s
[10:57:33.189] Received PubSub notification, asking Buildbucket for the build status
[10:57:33.218] Build status: SCHEDULED
[10:58:40.971] Received PubSub notification, asking Buildbucket for the build status
[10:58:40.991] Build status: STARTED
[10:59:50.617] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:2:0)
[10:59:50.641] Build status: STARTED
[10:59:50.641] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:5:0) after 2m25s
[11:02:15.721] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:5:0)
[11:02:15.763] Build status: STARTED
[11:02:15.763] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:6:0) after 9m51s
[11:12:06.881] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:6:0)
[11:12:06.907] Build status: STARTED
[11:12:06.907] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:7:0) after 1m41s
[11:13:47.938] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:7:0)
[11:13:47.957] Build status: STARTED
[11:13:47.957] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:8:0) after 4m29s
[11:18:16.937] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:8:0)
[11:18:16.956] Build status: STARTED
[11:18:16.956] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:9:0) after 4m40s
[11:22:57.109] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:9:0)
[11:22:57.131] Build status: STARTED
[11:22:57.131] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:10:0) after 2m15s
[11:25:12.156] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:10:0)
[11:25:12.195] Build status: STARTED
[11:25:12.195] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:11:0) after 2m37s
[11:27:49.339] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:11:0)
[11:27:49.362] Build status: STARTED
[11:27:49.362] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:12:0) after 5m0s
[11:32:49.708] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:12:0)
[11:32:49.727] Build status: STARTED
[11:32:49.727] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:13:0) after 8m44s
[11:41:33.744] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:13:0)
[11:41:33.765] Build status: STARTED
[11:41:33.765] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:14:0) after 9m5s
[11:50:38.825] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:14:0)
[11:50:38.850] Build status: STARTED
[11:50:38.850] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:15:0) after 1m42s
[11:52:21.085] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:15:0)
[11:52:21.104] Build status: STARTED
[11:52:21.104] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:16:0) after 7m37s
[11:59:58.191] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:16:0)
[11:59:58.211] Build status: STARTED
[11:59:58.211] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:17:0) after 3m24s
[12:03:22.244] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:17:0)
[12:03:22.336] Build status: STARTED
[12:03:22.336] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:18:0) after 5m29s
[12:08:51.461] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:18:0)
[12:08:51.484] Build status: STARTED
[12:08:51.485] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:19:0) after 7m57s
[12:16:48.517] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:19:0)
[12:16:48.548] Build status: STARTED
[12:16:48.548] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:20:0) after 7m46s
[12:24:34.614] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:20:0)
[12:24:34.695] Build status: STARTED
[12:24:34.695] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:21:0) after 5m8s
[12:29:42.728] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:21:0)
[12:29:42.755] Build status: STARTED
[12:29:42.755] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:22:0) after 4m39s
[12:34:21.900] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:22:0)
[12:34:21.973] Build status: STARTED
[12:34:21.973] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:23:0) after 1m41s
[12:36:03.146] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:23:0)
[12:36:03.173] Build status: STARTED
[12:36:03.173] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:24:0) after 8m6s
[12:44:09.364] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:24:0)
[12:44:09.398] Build status: STARTED
[12:44:09.398] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:25:0) after 3m55s
[12:48:04.497] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:25:0)
[12:48:04.518] Build status: STARTED
[12:48:04.518] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:26:0) after 9m33s
[12:57:37.963] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:26:0)
[12:57:37.990] Build status: STARTED
[12:57:37.990] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:27:0) after 5m5s
[13:02:43.098] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:27:0)
[13:02:43.165] Build status: STARTED
[13:02:43.165] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:28:0) after 8m46s
[13:11:29.189] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:28:0)
[13:11:29.216] Build status: STARTED
[13:11:29.216] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:29:0) after 6m37s
[13:18:06.322] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:29:0)
[13:18:06.343] Build status: STARTED
[13:18:06.343] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:30:0) after 1m46s
[13:19:52.393] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:30:0)
[13:19:52.435] Build status: STARTED
[13:19:52.435] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:31:0) after 2m40s
[13:22:32.643] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:31:0)
[13:22:32.663] Build status: STARTED
[13:22:32.663] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:32:0) after 5m1s
[13:27:33.797] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:32:0)
[13:27:33.885] Build status: STARTED
[13:27:33.885] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:33:0) after 7m39s
[13:35:12.952] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:33:0)
[13:35:13.002] Build status: STARTED
[13:35:13.002] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:34:0) after 6m16s
[13:41:29.357] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:34:0)
[13:41:29.378] Build status: STARTED
[13:41:29.378] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:35:0) after 7m33s
[13:49:02.611] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:35:0)
[13:49:02.653] Build status: STARTED
[13:49:02.653] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:36:0) after 7m18s
[13:56:20.660] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:36:0)
[13:56:20.684] Build status: STARTED
[13:56:20.684] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:37:0) after 9m57s
[14:06:17.960] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:37:0)
[14:06:17.978] Build status: STARTED
[14:06:17.978] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:38:0) after 4m58s
[14:11:16.124] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:38:0)
[14:11:16.146] Build status: STARTED
[14:11:16.146] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:39:0) after 8m47s
[14:20:03.217] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:39:0)
[14:20:03.246] Build status: STARTED
[14:20:03.246] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:40:0) after 3m0s
[14:23:03.314] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:40:0)
[14:23:03.343] Build status: STARTED
[14:23:03.343] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:41:0) after 6m4s
[14:29:07.686] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:41:0)
[14:29:07.705] Build status: STARTED
[14:29:07.705] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:42:0) after 6m47s
[14:35:54.724] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:42:0)
[14:35:54.759] Build status: STARTED
[14:35:54.760] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:43:0) after 1m48s
[14:37:42.845] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:43:0)
[14:37:42.866] Build status: STARTED
[14:37:42.866] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:44:0) after 8m32s
[14:46:14.925] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:44:0)
[14:46:14.962] Build status: STARTED
[14:46:14.962] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:45:0) after 1m14s
[14:47:29.078] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:45:0)
[14:47:29.096] Build status: STARTED
[14:47:29.097] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:46:0) after 5m48s
[14:53:17.117] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:46:0)
[14:53:17.150] Build status: STARTED
[14:53:17.150] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:47:0) after 5m32s
[14:58:49.188] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:47:0)
[14:58:49.224] Build status: STARTED
[14:58:49.224] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:48:0) after 1m37s
[15:00:26.264] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:48:0)
[15:00:26.316] Build status: STARTED
[15:00:26.316] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:49:0) after 8m41s
[15:09:07.373] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:49:0)
[15:09:07.444] Build status: STARTED
[15:09:07.444] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:50:0) after 9m15s
[15:18:22.591] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:50:0)
[15:18:22.610] Build status: STARTED
[15:18:22.610] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:51:0) after 7m50s
[15:26:12.882] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:51:0)
[15:26:12.901] Build status: STARTED
[15:26:12.901] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:52:0) after 1m12s
[15:27:25.211] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:52:0)
[15:27:25.233] Build status: STARTED
[15:27:25.233] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:53:0) after 6m49s
[15:34:14.544] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:53:0)
[15:34:14.584] Build status: STARTED
[15:34:14.584] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:54:0) after 5m24s
[15:39:39.202] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:54:0)
[15:39:39.224] Build status: STARTED
[15:39:39.224] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:55:0) after 1m55s
[15:41:34.314] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:55:0)
[15:41:34.357] Build status: STARTED
[15:41:34.357] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:56:0) after 1m6s
[15:42:40.672] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:56:0)
[15:42:40.839] Build status: STARTED
[15:42:40.840] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:57:0) after 6m19s
[15:49:00.352] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:57:0)
[15:49:00.569] Build status: STARTED
[15:49:00.569] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:58:0) after 2m10s
[15:51:10.679] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:58:0)
[15:51:10.699] Build status: STARTED
[15:51:10.699] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:59:0) after 1m25s
[15:52:35.786] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:59:0)
[15:52:35.809] Build status: STARTED
[15:52:35.809] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:60:0) after 7m30s
[16:00:05.835] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:60:0)
[16:00:05.861] Build status: STARTED
[16:00:05.861] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:61:0) after 5m59s
[16:06:04.890] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:61:0)
[16:06:04.933] Build status: STARTED
[16:06:04.933] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:62:0) after 6m12s
[16:12:17.030] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:62:0)
[16:12:17.113] Build status: STARTED
[16:12:17.113] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:63:0) after 9m13s
[16:21:30.158] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:63:0)
[16:21:30.234] Build status: STARTED
[16:21:30.234] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:64:0) after 4m30s
[16:26:00.266] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:64:0)
[16:26:00.321] Build status: STARTED
[16:26:00.321] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:65:0) after 6m43s
[16:32:43.348] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:65:0)
[16:32:43.368] Build status: STARTED
[16:32:43.368] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:66:0) after 7m35s
[16:40:18.412] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:66:0)
[16:40:18.430] Build status: STARTED
[16:40:18.430] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:67:0) after 7m37s
[16:47:55.529] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:67:0)
[16:47:55.550] Build status: STARTED
[16:47:55.550] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:68:0) after 9m44s
[16:57:39.653] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:68:0)
[16:57:39.674] Build status: STARTED
[16:57:39.674] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:69:0) after 6m12s
[17:03:51.699] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:69:0)
[17:03:51.725] Build status: STARTED
[17:03:51.725] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:70:0) after 9m23s
[17:13:14.752] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:70:0)
[17:13:14.776] Build status: STARTED
[17:13:14.776] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:71:0) after 2m54s
[17:16:08.764] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:71:0)
[17:16:08.784] Build status: STARTED
[17:16:08.784] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:72:0) after 4m31s
[17:20:39.919] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:72:0)
[17:20:39.948] Build status: STARTED
[17:20:39.948] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:73:0) after 9m40s
[17:30:19.969] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:73:0)
[17:30:19.991] Build status: STARTED
[17:30:19.991] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:74:0) after 3m19s
[17:33:39.064] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:74:0)
[17:33:39.186] Build status: STARTED
[17:33:39.186] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:75:0) after 5m41s
[17:39:20.207] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:75:0)
[17:39:20.225] Build status: STARTED
[17:39:20.225] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:76:0) after 2m3s
[17:41:23.283] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:76:0)
[17:41:23.300] Build status: STARTED
[17:41:23.300] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:77:0) after 2m34s
[17:43:57.362] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:77:0)
[17:43:57.381] Build status: STARTED
[17:43:57.382] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:78:0) after 1m57s
[17:45:54.407] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:78:0)
[17:45:54.425] Build status: STARTED
[17:45:54.425] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:79:0) after 1m50s
[17:47:44.456] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:79:0)
[17:47:44.473] Build status: STARTED
[17:47:44.473] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:80:0) after 2m1s
[17:49:45.491] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:80:0)
[17:49:45.521] Build status: STARTED
[17:49:45.521] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:81:0) after 4m55s
[17:54:40.553] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:81:0)
[17:54:40.579] Build status: STARTED
[17:54:40.579] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:82:0) after 6m4s
[18:00:44.559] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:82:0)
[18:00:44.576] Build status: STARTED
[18:00:44.576] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:83:0) after 8m44s
[18:09:28.620] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:83:0)
[18:09:28.674] Build status: STARTED
[18:09:28.674] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:84:0) after 3m10s
[18:12:38.755] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:84:0)
[18:12:38.846] Build status: STARTED
[18:12:38.846] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:85:0) after 7m55s
[18:20:33.898] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:85:0)
[18:20:33.917] Build status: STARTED
[18:20:33.917] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:86:0) after 6m6s
[18:26:40.043] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:86:0)
[18:26:40.061] Build status: STARTED
[18:26:40.061] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:87:0) after 2m2s
[18:28:42.081] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:87:0)
[18:28:42.102] Build status: STARTED
[18:28:42.102] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:88:0) after 8m54s
[18:37:36.133] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:88:0)
[18:37:36.204] Build status: STARTED
[18:37:36.204] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:89:0) after 5m24s
[18:43:00.193] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:89:0)
[18:43:00.212] Build status: STARTED
[18:43:00.212] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:90:0) after 2m34s
[18:45:34.283] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:90:0)
[18:45:34.307] Build status: STARTED
[18:45:34.307] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:91:0) after 2m8s
[18:47:42.339] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:91:0)
[18:47:42.358] Build status: STARTED
[18:47:42.358] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:92:0) after 6m5s
[18:53:47.343] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:92:0)
[18:53:47.363] Build status: STARTED
[18:53:47.363] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:93:0) after 7m25s
[19:01:12.435] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:93:0)
[19:01:12.468] Build status: STARTED
[19:01:12.468] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:94:0) after 9m24s
[19:10:36.502] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:94:0)
[19:10:36.532] Build status: STARTED
[19:10:36.532] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:95:0) after 2m0s
[19:12:36.560] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:95:0)
[19:12:36.576] Build status: STARTED
[19:12:36.576] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:96:0) after 6m58s
[19:19:34.642] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:96:0)
[19:19:34.660] Build status: STARTED
[19:19:34.660] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:97:0) after 6m58s
[19:26:32.729] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:97:0)
[19:26:32.750] Build status: STARTED
[19:26:32.750] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:98:0) after 9m28s
[19:36:00.822] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:98:0)
[19:36:00.847] Build status: STARTED
[19:36:00.847] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:99:0) after 8m24s
[19:44:24.936] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:99:0)
[19:44:24.963] Build status: STARTED
[19:44:24.963] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:100:0) after 8m33s
[19:52:58.018] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:100:0)
[19:52:58.051] Build status: STARTED
[19:52:58.051] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:101:0) after 7m26s
[20:00:24.120] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:101:0)
[20:00:24.150] Build status: STARTED
[20:00:24.150] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:102:0) after 3m49s
[20:04:13.215] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:102:0)
[20:04:13.250] Build status: STARTED
[20:04:13.250] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:103:0) after 6m13s
[20:10:26.988] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:103:0)
[20:10:27.014] Build status: STARTED
[20:10:27.014] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:104:0) after 5m29s
[20:15:56.053] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:104:0)
[20:15:56.125] Build status: STARTED
[20:15:56.125] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:105:0) after 9m2s
[20:24:58.199] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:105:0)
[20:24:58.223] Build status: STARTED
[20:24:58.223] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:106:0) after 6m2s
[20:31:00.265] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:106:0)
[20:31:00.295] Build status: STARTED
[20:31:00.295] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:107:0) after 4m28s
[20:35:28.355] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:107:0)
[20:35:28.432] Build status: STARTED
[20:35:28.432] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:108:0) after 3m53s
[20:39:21.455] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:108:0)
[20:39:21.478] Build status: STARTED
[20:39:21.478] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:109:0) after 1m20s
[20:40:41.538] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:109:0)
[20:40:41.555] Build status: STARTED
[20:40:41.555] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:110:0) after 6m3s
[20:46:44.591] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:110:0)
[20:46:44.614] Build status: STARTED
[20:46:44.614] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:111:0) after 6m45s
[20:53:29.641] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:111:0)
[20:53:29.691] Build status: STARTED
[20:53:29.691] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8931155453871780864:112:0) after 8m52s
[21:01:49.734] Received PubSub notification, asking Buildbucket for the build status
[21:01:49.754] Build:
{
"id": "8765725391705634145",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "fuchsia-fyi-x64-asan"
},
"number": 4507,
"createdBy": "project:chromium",
"createTime": "2023-10-31T10:57:31.468843874Z",
"startTime": "2023-10-31T10:58:40.372777Z",
"endTime": "2023-10-31T21:01:48.758556Z",
"updateTime": "2023-10-31T21:01:48.758556Z",
"status": "INFRA_FAILURE",
"statusDetails": {
"timeout": {
}
},
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "8d43cc12aae5a4421b5c864ecc489500ab4e0faf",
"ref": "refs/heads/main"
}
}
}
[21:01:49.754] Invocation finished in 10h4m19.735913105s with status FAILED