[03:12:39.711] New invocation is queued and will start shortly
[03:12:44.372] Starting the invocation (attempt 1)
[03:12:44.415] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e94b6b99a7c9e560b936ac422d69ce413a2b78b3"
[03:12:44.415] Popped gitiles commit info from properties and tags
[03:12:44.415] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:12:44.415] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:12:44.415] Buildbucket request:
{
"requestId": "8990616308952743168",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "fuchsia-fyi-x64-asan"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e94b6b99a7c9e560b936ac422d69ce413a2b78b3",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8990616308952743168"
},
{
"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"
}
}
[03:12:44.933] Scheduled build:
{
"id": "8825186243291264337",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "fuchsia-fyi-x64-asan"
},
"number": 336,
"createdBy": "project:chromium",
"createTime": "2022-01-13T03:12:44.479894062Z",
"updateTime": "2022-01-13T03:12:44.479894062Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e94b6b99a7c9e560b936ac422d69ce413a2b78b3",
"ref": "refs/heads/main"
}
}
}
[03:12:44.933] Task URL: https://cr-buildbucket.appspot.com/build/8825186243291264337
[03:12:44.933] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:2:0) after 5m52s
[03:16:22.968] Received PubSub notification, asking Buildbucket for the build status
[03:16:23.001] Build status: STARTED
[03:18:37.097] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:2:0)
[03:18:37.116] Build status: STARTED
[03:18:37.116] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:4:0) after 2m33s
[03:21:10.710] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:4:0)
[03:21:10.743] Build status: STARTED
[03:21:10.743] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:5:0) after 5m39s
[03:26:49.822] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:5:0)
[03:26:49.856] Build status: STARTED
[03:26:49.856] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:6:0) after 5m1s
[03:31:50.886] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:6:0)
[03:31:51.229] Build status: STARTED
[03:31:51.229] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:7:0) after 6m51s
[03:38:42.411] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:7:0)
[03:38:42.428] Build status: STARTED
[03:38:42.428] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:8:0) after 4m12s
[03:42:54.832] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:8:0)
[03:42:54.873] Build status: STARTED
[03:42:54.873] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:9:0) after 4m45s
[03:47:39.906] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:9:0)
[03:47:39.927] Build status: STARTED
[03:47:39.927] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:10:0) after 2m53s
[03:50:33.025] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:10:0)
[03:50:33.046] Build status: STARTED
[03:50:33.046] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:11:0) after 6m25s
[03:56:58.157] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:11:0)
[03:56:58.188] Build status: STARTED
[03:56:58.188] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:12:0) after 2m26s
[03:59:24.315] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:12:0)
[03:59:24.332] Build status: STARTED
[03:59:24.332] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:13:0) after 6m39s
[04:06:03.360] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:13:0)
[04:06:03.386] Build status: STARTED
[04:06:03.386] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:14:0) after 4m24s
[04:10:27.854] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:14:0)
[04:10:27.874] Build status: STARTED
[04:10:27.874] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:15:0) after 3m12s
[04:13:39.900] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:15:0)
[04:13:39.921] Build status: STARTED
[04:13:39.921] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:16:0) after 2m38s
[04:16:18.062] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:16:0)
[04:16:18.084] Build status: STARTED
[04:16:18.084] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:17:0) after 5m27s
[04:21:45.427] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:17:0)
[04:21:45.446] Build status: STARTED
[04:21:45.446] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:18:0) after 9m56s
[04:31:41.483] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:18:0)
[04:31:41.568] Build status: STARTED
[04:31:41.568] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:19:0) after 5m52s
[04:37:33.690] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:19:0)
[04:37:33.712] Build status: STARTED
[04:37:33.712] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:20:0) after 6m6s
[04:43:39.752] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:20:0)
[04:43:39.790] Build status: STARTED
[04:43:39.790] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:21:0) after 8m3s
[04:51:42.837] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:21:0)
[04:51:42.871] Build status: STARTED
[04:51:42.871] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:22:0) after 7m38s
[04:59:20.917] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:22:0)
[04:59:20.939] Build status: STARTED
[04:59:20.939] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:23:0) after 7m17s
[05:06:37.969] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:23:0)
[05:06:37.999] Build status: STARTED
[05:06:37.999] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:24:0) after 6m57s
[05:13:35.031] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:24:0)
[05:13:35.054] Build status: STARTED
[05:13:35.054] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:25:0) after 8m11s
[05:21:46.277] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:25:0)
[05:21:46.301] Build status: STARTED
[05:21:46.301] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:26:0) after 6m41s
[05:28:27.334] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:26:0)
[05:28:27.379] Build status: STARTED
[05:28:27.379] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:27:0) after 3m37s
[05:32:05.069] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:27:0)
[05:32:05.104] Build status: STARTED
[05:32:05.104] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:28:0) after 1m18s
[05:33:23.136] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:28:0)
[05:33:23.159] Build status: STARTED
[05:33:23.159] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:29:0) after 2m22s
[05:35:45.418] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:29:0)
[05:35:45.472] Build status: STARTED
[05:35:45.472] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:30:0) after 3m9s
[05:38:54.766] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:30:0)
[05:38:54.796] Build status: STARTED
[05:38:54.796] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:31:0) after 8m59s
[05:47:53.928] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:31:0)
[05:47:53.952] Build status: STARTED
[05:47:53.952] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:32:0) after 5m16s
[05:53:10.037] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:32:0)
[05:53:10.061] Build status: STARTED
[05:53:10.061] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:33:0) after 9m38s
[06:02:48.095] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:33:0)
[06:02:48.133] Build status: STARTED
[06:02:48.133] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:34:0) after 6m31s
[06:09:19.261] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:34:0)
[06:09:19.293] Build status: STARTED
[06:09:19.293] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:35:0) after 3m13s
[06:12:32.525] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:35:0)
[06:12:32.590] Build status: STARTED
[06:12:32.590] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:36:0) after 4m40s
[06:17:12.799] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:36:0)
[06:17:12.822] Build status: STARTED
[06:17:12.822] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:37:0) after 9m31s
[06:26:43.967] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:37:0)
[06:26:44.043] Build status: STARTED
[06:26:44.043] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:38:0) after 7m29s
[06:34:13.286] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:38:0)
[06:34:13.306] Build status: STARTED
[06:34:13.307] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:39:0) after 7m1s
[06:41:14.357] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:39:0)
[06:41:14.376] Build status: STARTED
[06:41:14.376] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:40:0) after 1m16s
[06:42:30.485] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:40:0)
[06:42:30.509] Build status: STARTED
[06:42:30.509] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:41:0) after 2m35s
[06:45:05.635] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:41:0)
[06:45:05.656] Build status: STARTED
[06:45:05.656] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:42:0) after 9m49s
[06:54:54.826] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:42:0)
[06:54:54.848] Build status: STARTED
[06:54:54.848] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:43:0) after 8m19s
[07:03:14.002] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:43:0)
[07:03:14.077] Build status: STARTED
[07:03:14.077] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:44:0) after 1m17s
[07:04:31.274] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:44:0)
[07:04:31.303] Build status: STARTED
[07:04:31.303] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:45:0) after 2m12s
[07:06:43.423] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:45:0)
[07:06:43.465] Build status: STARTED
[07:06:43.465] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:46:0) after 5m8s
[07:11:51.598] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:46:0)
[07:11:51.625] Build status: STARTED
[07:11:51.625] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:47:0) after 9m54s
[07:21:45.651] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:47:0)
[07:21:45.680] Build status: STARTED
[07:21:45.680] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:48:0) after 4m9s
[07:25:54.710] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:48:0)
[07:25:54.730] Build status: STARTED
[07:25:54.730] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:49:0) after 4m33s
[07:30:27.863] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:49:0)
[07:30:27.884] Build status: STARTED
[07:30:27.884] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:50:0) after 3m35s
[07:34:02.991] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:50:0)
[07:34:03.026] Build status: STARTED
[07:34:03.026] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:51:0) after 3m47s
[07:37:50.128] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:51:0)
[07:37:50.151] Build status: STARTED
[07:37:50.151] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:52:0) after 8m37s
[07:46:27.182] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:52:0)
[07:46:27.210] Build status: STARTED
[07:46:27.210] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:53:0) after 3m36s
[07:50:03.242] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:53:0)
[07:50:03.279] Build status: STARTED
[07:50:03.279] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:54:0) after 9m9s
[07:59:12.699] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:54:0)
[07:59:12.755] Build status: STARTED
[07:59:12.755] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:55:0) after 5m47s
[08:04:59.910] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:55:0)
[08:04:59.960] Build status: STARTED
[08:04:59.960] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:56:0) after 4m43s
[08:09:42.959] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:56:0)
[08:09:42.996] Build status: STARTED
[08:09:42.996] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:57:0) after 9m9s
[08:18:52.033] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:57:0)
[08:18:52.063] Build status: STARTED
[08:18:52.063] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:58:0) after 5m5s
[08:23:57.107] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:58:0)
[08:23:57.139] Build status: STARTED
[08:23:57.139] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:59:0) after 2m54s
[08:26:51.272] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:59:0)
[08:26:51.447] Build status: STARTED
[08:26:51.447] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:60:0) after 7m47s
[08:34:38.613] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:60:0)
[08:34:38.714] Build status: STARTED
[08:34:38.714] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:61:0) after 2m46s
[08:37:24.712] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:61:0)
[08:37:24.777] Build status: STARTED
[08:37:24.777] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:62:0) after 4m59s
[08:42:23.944] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:62:0)
[08:42:23.966] Build status: STARTED
[08:42:23.966] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:63:0) after 6m55s
[08:49:19.102] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:63:0)
[08:49:19.136] Build status: STARTED
[08:49:19.136] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:64:0) after 9m39s
[08:58:58.300] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:64:0)
[08:58:58.331] Build status: STARTED
[08:58:58.331] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:65:0) after 1m8s
[09:00:06.358] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:65:0)
[09:00:06.396] Build status: STARTED
[09:00:06.396] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:66:0) after 8m25s
[09:08:31.552] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:66:0)
[09:08:31.576] Build status: STARTED
[09:08:31.576] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:67:0) after 6m47s
[09:15:18.844] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:67:0)
[09:15:18.866] Build status: STARTED
[09:15:18.866] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:68:0) after 3m44s
[09:19:02.906] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:68:0)
[09:19:02.941] Build status: STARTED
[09:19:02.941] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:69:0) after 7m2s
[09:26:05.017] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:69:0)
[09:26:05.048] Build status: STARTED
[09:26:05.048] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:70:0) after 1m52s
[09:27:57.273] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:70:0)
[09:27:57.330] Build status: STARTED
[09:27:57.330] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:71:0) after 5m13s
[09:33:10.447] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:71:0)
[09:33:10.487] Build status: STARTED
[09:33:10.487] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:72:0) after 1m49s
[09:34:59.518] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:72:0)
[09:34:59.546] Build status: STARTED
[09:34:59.546] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:73:0) after 1m43s
[09:36:42.575] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:73:0)
[09:36:42.602] Build status: STARTED
[09:36:42.602] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:74:0) after 5m29s
[09:42:11.695] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:74:0)
[09:42:11.755] Build status: STARTED
[09:42:11.755] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:75:0) after 3m53s
[09:46:04.772] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:75:0)
[09:46:04.793] Build status: STARTED
[09:46:04.793] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:76:0) after 3m6s
[09:49:10.838] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:76:0)
[09:49:10.868] Build status: STARTED
[09:49:10.868] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:77:0) after 7m26s
[09:56:36.997] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:77:0)
[09:56:37.035] Build status: STARTED
[09:56:37.035] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:78:0) after 7m47s
[10:04:24.175] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:78:0)
[10:04:24.210] Build status: STARTED
[10:04:24.210] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:79:0) after 6m51s
[10:11:15.421] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:79:0)
[10:11:15.543] Build status: STARTED
[10:11:15.543] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:80:0) after 9m59s
[10:21:14.767] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:80:0)
[10:21:14.789] Build status: STARTED
[10:21:14.789] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:81:0) after 1m55s
[10:23:09.828] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:81:0)
[10:23:09.879] Build status: STARTED
[10:23:09.879] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:82:0) after 3m18s
[10:26:27.974] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:82:0)
[10:26:28.006] Build status: STARTED
[10:26:28.006] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:83:0) after 2m55s
[10:29:23.040] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:83:0)
[10:29:23.068] Build status: STARTED
[10:29:23.068] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:84:0) after 6m31s
[10:35:54.394] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:84:0)
[10:35:54.411] Build status: STARTED
[10:35:54.411] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:85:0) after 7m45s
[10:43:39.442] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:85:0)
[10:43:39.465] Build status: STARTED
[10:43:39.465] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:86:0) after 3m27s
[10:47:06.494] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:86:0)
[10:47:06.545] Build status: STARTED
[10:47:06.546] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:87:0) after 3m26s
[10:50:32.585] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:87:0)
[10:50:32.603] Build status: STARTED
[10:50:32.603] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:88:0) after 3m31s
[10:54:03.630] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:88:0)
[10:54:03.674] Build status: STARTED
[10:54:03.674] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:89:0) after 8m59s
[11:03:02.713] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:89:0)
[11:03:02.739] Build status: STARTED
[11:03:02.739] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:90:0) after 6m3s
[11:09:05.771] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:90:0)
[11:09:05.791] Build status: STARTED
[11:09:05.791] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:91:0) after 1m9s
[11:10:14.894] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:91:0)
[11:10:14.929] Build status: STARTED
[11:10:14.929] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:92:0) after 4m36s
[11:14:50.962] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:92:0)
[11:14:50.983] Build status: STARTED
[11:14:50.983] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:93:0) after 2m49s
[11:17:40.213] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:93:0)
[11:17:40.233] Build status: STARTED
[11:17:40.234] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:94:0) after 8m38s
[11:26:18.303] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:94:0)
[11:26:18.323] Build status: STARTED
[11:26:18.323] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:95:0) after 4m30s
[11:30:48.487] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:95:0)
[11:30:48.510] Build status: STARTED
[11:30:48.510] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:96:0) after 9m51s
[11:40:39.722] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:96:0)
[11:40:39.753] Build status: STARTED
[11:40:39.753] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:97:0) after 8m12s
[11:48:51.953] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:97:0)
[11:48:51.983] Build status: STARTED
[11:48:51.983] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:98:0) after 4m6s
[11:52:58.104] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:98:0)
[11:52:58.123] Build status: STARTED
[11:52:58.123] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:99:0) after 3m15s
[11:56:13.156] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:99:0)
[11:56:13.180] Build status: STARTED
[11:56:13.180] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:100:0) after 1m42s
[11:57:55.355] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:100:0)
[11:57:55.380] Build status: STARTED
[11:57:55.380] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:101:0) after 3m53s
[12:01:48.739] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:101:0)
[12:01:48.796] Build status: STARTED
[12:01:48.796] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:102:0) after 2m11s
[12:03:59.826] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:102:0)
[12:03:59.846] Build status: STARTED
[12:03:59.846] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:103:0) after 5m6s
[12:09:05.880] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:103:0)
[12:09:05.902] Build status: STARTED
[12:09:05.902] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:104:0) after 2m20s
[12:11:25.985] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:104:0)
[12:11:26.034] Build status: STARTED
[12:11:26.034] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:105:0) after 2m26s
[12:13:52.747] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:105:0)
[12:13:52.768] Build status: STARTED
[12:13:52.768] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:106:0) after 5m7s
[12:18:59.816] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:106:0)
[12:18:59.846] Build status: STARTED
[12:18:59.846] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:107:0) after 5m59s
[12:24:59.106] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:107:0)
[12:24:59.138] Build status: STARTED
[12:24:59.138] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:108:0) after 9m52s
[12:34:51.170] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:108:0)
[12:34:51.198] Build status: STARTED
[12:34:51.198] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:109:0) after 7m11s
[12:42:02.361] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:109:0)
[12:42:02.387] Build status: STARTED
[12:42:02.387] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:110:0) after 2m56s
[12:44:58.478] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:110:0)
[12:44:58.529] Build status: STARTED
[12:44:58.529] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:111:0) after 6m7s
[12:51:05.781] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:111:0)
[12:51:05.857] Build status: STARTED
[12:51:05.857] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:112:0) after 4m17s
[12:55:22.911] Handling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:112:0)
[12:55:22.958] Build status: STARTED
[12:55:22.958] Scheduling timer "check-buildbucket-build-status" (chromium/fuchsia-fyi-x64-asan:8990616308952743168:113:0) after 5m9s
[12:59:17.835] Received PubSub notification, asking Buildbucket for the build status
[12:59:17.854] Build:
{
"id": "8825186243291264337",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "fuchsia-fyi-x64-asan"
},
"number": 336,
"createdBy": "project:chromium",
"createTime": "2022-01-13T03:12:44.479894062Z",
"startTime": "2022-01-13T03:16:22.173663Z",
"endTime": "2022-01-13T12:59:17.486291576Z",
"updateTime": "2022-01-13T12:59:17.486291576Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e94b6b99a7c9e560b936ac422d69ce413a2b78b3",
"ref": "refs/heads/main"
}
}
}
[12:59:17.854] Invocation finished in 9h46m38.158415512s with status FAILED