[13:53:46.850] New invocation is queued and will start shortly
[13:53:48.173] Starting the invocation (attempt 1)
[13:53:48.203] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1013a346df25785479df63fec9d49b6509011979"
[13:53:48.203] Popped gitiles commit info from properties and tags
[13:53:48.204] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:53:48.204] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:53:48.204] Buildbucket request:
{
"requestId": "8932865705645000080",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "fuchsia-fyi-x64-asan"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "1013a346df25785479df63fec9d49b6509011979",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8932865705645000080"
},
{
"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"
}
}
[13:53:48.850] Scheduled build:
{
"id": "8767435643482849313",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "fuchsia-fyi-x64-asan"
},
"number": 4436,
"createdBy": "project:chromium",
"createTime": "2023-10-12T13:53:48.273431002Z",
"updateTime": "2023-10-12T13:53:48.273431002Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "1013a346df25785479df63fec9d49b6509011979",
"ref": "refs/heads/main"
}
},
"canary": true
}
[13:53:48.850] Task URL: https://cr-buildbucket.appspot.com/build/8767435643482849313
[13:53:48.850] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:2:0) after 1m19s
[13:53:49.753] Received PubSub notification, asking Buildbucket for the build status
[13:53:49.775] Build status: SCHEDULED
[13:55:08.043] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:2:0)
[13:55:08.129] Build status: SCHEDULED
[13:55:08.129] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:4:0) after 1m9s
[13:55:44.772] Received PubSub notification, asking Buildbucket for the build status
[13:55:44.789] Build status: STARTED
[13:56:17.153] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:4:0)
[13:56:17.186] Build status: STARTED
[13:56:17.186] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:6:0) after 8m31s
[14:04:48.367] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:6:0)
[14:04:48.384] Build status: STARTED
[14:04:48.385] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:7:0) after 2m42s
[14:07:30.532] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:7:0)
[14:07:30.547] Build status: STARTED
[14:07:30.547] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:8:0) after 3m48s
[14:11:18.665] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:8:0)
[14:11:18.685] Build status: STARTED
[14:11:18.685] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:9:0) after 6m38s
[14:17:56.777] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:9:0)
[14:17:56.795] Build status: STARTED
[14:17:56.795] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:10:0) after 2m14s
[14:20:11.209] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:10:0)
[14:20:11.279] Build status: STARTED
[14:20:11.279] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:11:0) after 6m40s
[14:26:51.665] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:11:0)
[14:26:51.763] Build status: STARTED
[14:26:51.763] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:12:0) after 3m11s
[14:30:02.899] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:12:0)
[14:30:02.934] Build status: STARTED
[14:30:02.934] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:13:0) after 7m9s
[14:37:12.117] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:13:0)
[14:37:12.135] Build status: STARTED
[14:37:12.135] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:14:0) after 8m42s
[14:45:54.219] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:14:0)
[14:45:54.250] Build status: STARTED
[14:45:54.250] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:15:0) after 2m13s
[14:48:07.999] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:15:0)
[14:48:08.019] Build status: STARTED
[14:48:08.019] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:16:0) after 1m41s
[14:49:49.089] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:16:0)
[14:49:49.111] Build status: STARTED
[14:49:49.111] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:17:0) after 2m19s
[14:52:08.186] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:17:0)
[14:52:08.243] Build status: STARTED
[14:52:08.243] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:18:0) after 8m59s
[15:01:07.627] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:18:0)
[15:01:07.659] Build status: STARTED
[15:01:07.659] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:19:0) after 5m54s
[15:07:01.866] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:19:0)
[15:07:01.929] Build status: STARTED
[15:07:01.929] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:20:0) after 7m57s
[15:14:59.001] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:20:0)
[15:14:59.018] Build status: STARTED
[15:14:59.018] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:21:0) after 6m23s
[15:21:21.989] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:21:0)
[15:21:22.007] Build status: STARTED
[15:21:22.007] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:22:0) after 4m28s
[15:25:50.029] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:22:0)
[15:25:50.046] Build status: STARTED
[15:25:50.046] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:23:0) after 7m40s
[15:33:30.466] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:23:0)
[15:33:30.489] Build status: STARTED
[15:33:30.489] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:24:0) after 1m59s
[15:35:30.012] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:24:0)
[15:35:30.058] Build status: STARTED
[15:35:30.058] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:25:0) after 6m3s
[15:41:33.168] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:25:0)
[15:41:33.193] Build status: STARTED
[15:41:33.193] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:26:0) after 4m51s
[15:46:24.234] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:26:0)
[15:46:24.276] Build status: STARTED
[15:46:24.276] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:27:0) after 7m45s
[15:54:09.302] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:27:0)
[15:54:09.324] Build status: STARTED
[15:54:09.324] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:28:0) after 8m33s
[16:02:42.356] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:28:0)
[16:02:42.430] Build status: STARTED
[16:02:42.430] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:29:0) after 4m36s
[16:07:18.458] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:29:0)
[16:07:18.497] Build status: STARTED
[16:07:18.497] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:30:0) after 1m2s
[16:08:20.525] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:30:0)
[16:08:20.649] Build status: STARTED
[16:08:20.649] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:31:0) after 5m18s
[16:13:38.824] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:31:0)
[16:13:38.841] Build status: STARTED
[16:13:38.841] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:32:0) after 3m43s
[16:17:22.029] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:32:0)
[16:17:22.055] Build status: STARTED
[16:17:22.055] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:33:0) after 3m48s
[16:21:10.514] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:33:0)
[16:21:10.549] Build status: STARTED
[16:21:10.549] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:34:0) after 1m54s
[16:23:05.200] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:34:0)
[16:23:05.226] Build status: STARTED
[16:23:05.226] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:35:0) after 5m54s
[16:28:59.475] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:35:0)
[16:28:59.547] Build status: STARTED
[16:28:59.547] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:36:0) after 5m37s
[16:34:36.876] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:36:0)
[16:34:36.901] Build status: STARTED
[16:34:36.901] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:37:0) after 2m38s
[16:37:14.961] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:37:0)
[16:37:14.978] Build status: STARTED
[16:37:14.978] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:38:0) after 5m57s
[16:43:12.143] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:38:0)
[16:43:12.159] Build status: STARTED
[16:43:12.159] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:39:0) after 8m55s
[16:52:07.354] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:39:0)
[16:52:07.434] Build status: STARTED
[16:52:07.434] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:40:0) after 2m41s
[16:54:48.536] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:40:0)
[16:54:48.555] Build status: STARTED
[16:54:48.555] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:41:0) after 8m44s
[17:03:32.753] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:41:0)
[17:03:32.775] Build status: STARTED
[17:03:32.775] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:42:0) after 3m22s
[17:06:54.816] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:42:0)
[17:06:54.841] Build status: STARTED
[17:06:54.841] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:43:0) after 7m43s
[17:14:38.043] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:43:0)
[17:14:38.065] Build status: STARTED
[17:14:38.065] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:44:0) after 5m41s
[17:20:19.261] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:44:0)
[17:20:19.310] Build status: STARTED
[17:20:19.310] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:45:0) after 1m20s
[17:21:39.303] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:45:0)
[17:21:39.324] Build status: STARTED
[17:21:39.324] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:46:0) after 5m8s
[17:26:47.486] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:46:0)
[17:26:47.544] Build status: STARTED
[17:26:47.544] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:47:0) after 2m59s
[17:29:46.616] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:47:0)
[17:29:46.632] Build status: STARTED
[17:29:46.632] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:48:0) after 1m26s
[17:31:12.765] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:48:0)
[17:31:12.855] Build status: STARTED
[17:31:12.855] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:49:0) after 9m50s
[17:41:02.931] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:49:0)
[17:41:02.959] Build status: STARTED
[17:41:02.959] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:50:0) after 9m32s
[17:50:35.012] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:50:0)
[17:50:35.032] Build status: STARTED
[17:50:35.032] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:51:0) after 7m11s
[17:57:46.048] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:51:0)
[17:57:46.069] Build status: STARTED
[17:57:46.069] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:52:0) after 5m14s
[18:03:00.162] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:52:0)
[18:03:00.186] Build status: STARTED
[18:03:00.186] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:53:0) after 4m35s
[18:07:35.331] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:53:0)
[18:07:35.355] Build status: STARTED
[18:07:35.355] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:54:0) after 2m50s
[18:10:25.423] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:54:0)
[18:10:25.457] Build status: STARTED
[18:10:25.457] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:55:0) after 5m43s
[18:16:08.565] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:55:0)
[18:16:08.588] Build status: STARTED
[18:16:08.588] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:56:0) after 5m46s
[18:21:54.775] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:56:0)
[18:21:54.795] Build status: STARTED
[18:21:54.795] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:57:0) after 4m36s
[18:26:30.813] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:57:0)
[18:26:30.831] Build status: STARTED
[18:26:30.831] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:58:0) after 9m59s
[18:36:29.893] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:58:0)
[18:36:29.928] Build status: STARTED
[18:36:29.928] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:59:0) after 6m32s
[18:43:01.947] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:59:0)
[18:43:01.968] Build status: STARTED
[18:43:01.968] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:60:0) after 7m41s
[18:50:43.010] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:60:0)
[18:50:43.025] Build status: STARTED
[18:50:43.025] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:61:0) after 4m35s
[18:55:18.286] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:61:0)
[18:55:18.359] Build status: STARTED
[18:55:18.359] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:62:0) after 4m24s
[18:59:42.384] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:62:0)
[18:59:42.404] Build status: STARTED
[18:59:42.404] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:63:0) after 7m37s
[19:07:19.548] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:63:0)
[19:07:19.568] Build status: STARTED
[19:07:19.569] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:64:0) after 9m8s
[19:16:27.562] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:64:0)
[19:16:27.622] Build status: STARTED
[19:16:27.622] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:65:0) after 7m24s
[19:23:51.689] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:65:0)
[19:23:51.744] Build status: STARTED
[19:23:51.744] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:66:0) after 9m33s
[19:33:24.769] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:66:0)
[19:33:24.793] Build status: STARTED
[19:33:24.793] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:67:0) after 4m15s
[19:37:39.813] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:67:0)
[19:37:40.011] Build status: STARTED
[19:37:40.011] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:68:0) after 3m25s
[19:41:05.042] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:68:0)
[19:41:05.130] Build status: STARTED
[19:41:05.130] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:69:0) after 1m9s
[19:42:14.176] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:69:0)
[19:42:14.195] Build status: STARTED
[19:42:14.195] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:70:0) after 2m24s
[19:44:38.756] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:70:0)
[19:44:38.832] Build status: STARTED
[19:44:38.832] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:71:0) after 1m54s
[19:46:32.834] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:71:0)
[19:46:32.862] Build status: STARTED
[19:46:32.862] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:72:0) after 5m43s
[19:52:15.910] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:72:0)
[19:52:15.978] Build status: STARTED
[19:52:15.978] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:73:0) after 6m47s
[19:59:03.138] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:73:0)
[19:59:03.155] Build status: STARTED
[19:59:03.155] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:74:0) after 4m35s
[20:03:38.150] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:74:0)
[20:03:38.186] Build status: STARTED
[20:03:38.187] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:75:0) after 8m59s
[20:12:37.210] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:75:0)
[20:12:37.335] Build status: STARTED
[20:12:37.335] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:76:0) after 4m15s
[20:16:52.354] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:76:0)
[20:16:52.375] Build status: STARTED
[20:16:52.375] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:77:0) after 8m54s
[20:25:46.367] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:77:0)
[20:25:46.440] Build status: STARTED
[20:25:46.441] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:78:0) after 2m50s
[20:28:36.462] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:78:0)
[20:28:36.496] Build status: STARTED
[20:28:36.496] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:79:0) after 3m59s
[20:32:35.715] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:79:0)
[20:32:35.773] Build status: STARTED
[20:32:35.773] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:80:0) after 1m50s
[20:34:25.813] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:80:0)
[20:34:25.873] Build status: STARTED
[20:34:25.873] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:81:0) after 3m38s
[20:38:04.164] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:81:0)
[20:38:04.184] Build status: STARTED
[20:38:04.184] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:82:0) after 8m53s
[20:46:57.209] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:82:0)
[20:46:57.234] Build status: STARTED
[20:46:57.235] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:83:0) after 3m27s
[20:50:24.416] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:83:0)
[20:50:24.436] Build status: STARTED
[20:50:24.436] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:84:0) after 3m37s
[20:54:01.458] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:84:0)
[20:54:01.478] Build status: STARTED
[20:54:01.478] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:85:0) after 2m24s
[20:56:25.515] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:85:0)
[20:56:25.534] Build status: STARTED
[20:56:25.534] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:86:0) after 6m26s
[21:02:51.561] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:86:0)
[21:02:51.581] Build status: STARTED
[21:02:51.581] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:87:0) after 1m49s
[21:04:40.600] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:87:0)
[21:04:40.621] Build status: STARTED
[21:04:40.621] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:88:0) after 7m46s
[21:12:26.643] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:88:0)
[21:12:26.688] Build status: STARTED
[21:12:26.688] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:89:0) after 8m27s
[21:20:53.829] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:89:0)
[21:20:53.850] Build status: STARTED
[21:20:53.850] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:90:0) after 5m52s
[21:26:46.022] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:90:0)
[21:26:46.040] Build status: STARTED
[21:26:46.041] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:91:0) after 7m42s
[21:34:28.072] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:91:0)
[21:34:28.091] Build status: STARTED
[21:34:28.091] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:92:0) after 1m39s
[21:36:07.347] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:92:0)
[21:36:07.423] Build status: STARTED
[21:36:07.423] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:93:0) after 7m26s
[21:43:33.867] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:93:0)
[21:43:33.915] Build status: STARTED
[21:43:33.915] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:94:0) after 9m9s
[21:52:42.949] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:94:0)
[21:52:42.964] Build status: STARTED
[21:52:42.964] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:95:0) after 4m48s
[21:57:31.225] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:95:0)
[21:57:31.242] Build status: STARTED
[21:57:31.242] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:96:0) after 5m37s
[22:03:08.366] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:96:0)
[22:03:08.391] Build status: STARTED
[22:03:08.391] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:97:0) after 3m20s
[22:06:28.623] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:97:0)
[22:06:28.645] Build status: STARTED
[22:06:28.645] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:98:0) after 1m56s
[22:08:24.843] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:98:0)
[22:08:24.864] Build status: STARTED
[22:08:24.864] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:99:0) after 2m19s
[22:10:44.169] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:99:0)
[22:10:44.257] Build status: STARTED
[22:10:44.257] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:100:0) after 1m22s
[22:12:06.381] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:100:0)
[22:12:06.436] Build status: STARTED
[22:12:06.436] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:101:0) after 6m29s
[22:18:35.460] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:101:0)
[22:18:35.479] Build status: STARTED
[22:18:35.479] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:102:0) after 2m11s
[22:20:46.665] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:102:0)
[22:20:46.757] Build status: STARTED
[22:20:46.757] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:103:0) after 7m31s
[22:28:17.888] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:103:0)
[22:28:17.911] Build status: STARTED
[22:28:17.911] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:104:0) after 9m47s
[22:38:04.988] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:104:0)
[22:38:05.033] Build status: STARTED
[22:38:05.033] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:105:0) after 8m54s
[22:46:59.058] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:105:0)
[22:46:59.079] Build status: STARTED
[22:46:59.079] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:106:0) after 8m37s
[22:55:36.198] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:106:0)
[22:55:36.219] Build status: STARTED
[22:55:36.219] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:107:0) after 7m5s
[23:02:41.321] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:107:0)
[23:02:41.345] Build status: STARTED
[23:02:41.345] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:108:0) after 7m14s
[23:09:55.462] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:108:0)
[23:09:55.480] Build status: STARTED
[23:09:55.480] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:109:0) after 7m34s
[23:17:29.631] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:109:0)
[23:17:29.713] Build status: STARTED
[23:17:29.714] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:110:0) after 9m40s
[23:27:09.833] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:110:0)
[23:27:09.896] Build status: STARTED
[23:27:09.896] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:111:0) after 2m5s
[23:29:14.919] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:111:0)
[23:29:14.946] Build status: STARTED
[23:29:14.946] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:112:0) after 9m1s
[23:38:15.978] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:112:0)
[23:38:16.009] Build status: STARTED
[23:38:16.009] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:113:0) after 6m12s
[23:44:28.056] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:113:0)
[23:44:28.072] Build status: STARTED
[23:44:28.072] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:114:0) after 1m27s
[23:45:55.096] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:114:0)
[23:45:55.118] Build status: STARTED
[23:45:55.118] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:115:0) after 3m58s
[23:49:53.193] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:115:0)
[23:49:53.219] Build status: STARTED
[23:49:53.219] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:116:0) after 1m19s
[23:51:12.254] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:116:0)
[23:51:12.308] Build status: STARTED
[23:51:12.308] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8932865705645000080:117:0) after 6m22s
[23:55:58.441] Received PubSub notification, asking Buildbucket for the build status
[23:55:58.545] Build:
{
"id": "8767435643482849313",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "fuchsia-fyi-x64-asan"
},
"number": 4436,
"createdBy": "project:chromium",
"createTime": "2023-10-12T13:53:48.273431002Z",
"startTime": "2023-10-12T13:55:44.258160Z",
"endTime": "2023-10-12T23:55:58.065751433Z",
"updateTime": "2023-10-12T23:55:58.065751433Z",
"status": "CANCELED",
"statusDetails": {
"timeout": {
}
},
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "1013a346df25785479df63fec9d49b6509011979",
"ref": "refs/heads/main"
}
},
"canary": true
}
[23:55:58.545] Invocation finished in 10h2m11.716695447s with status ABORTED