[01:44:37.056] New invocation is queued and will start shortly
[01:44:38.126] Starting the invocation (attempt 1)
[01:44:38.153] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e319f595e7e821546d0891a6f0b962e90c3be27e"
[01:44:38.153] Popped gitiles commit info from properties and tags
[01:44:38.153] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:44:38.153] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:44:38.153] Buildbucket request:
{
"requestId": "8876741461447171088",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "CrWinAsan"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e319f595e7e821546d0891a6f0b962e90c3be27e",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8876741461447171088"
},
{
"key": "scheduler_job_id",
"value": "chromium/CrWinAsan"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[01:44:38.727] Scheduled build:
{
"id": "8711311399475527905",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "CrWinAsan"
},
"number": 19049,
"createdBy": "project:chromium",
"createTime": "2025-06-23T01:44:38.311943549Z",
"updateTime": "2025-06-23T01:44:38.311943549Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e319f595e7e821546d0891a6f0b962e90c3be27e",
"ref": "refs/heads/main"
}
}
}
[01:44:38.727] Task URL: https://cr-buildbucket.appspot.com/build/8711311399475527905
[01:44:38.727] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:2:0) after 1m32s
[01:45:38.397] Received PubSub notification, asking Buildbucket for the build status
[01:45:38.418] Build status: SCHEDULED
[01:46:10.865] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:2:0)
[01:46:10.889] Build status: SCHEDULED
[01:46:10.890] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:4:0) after 2m44s
[01:48:54.910] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:4:0)
[01:48:54.962] Build status: SCHEDULED
[01:48:54.962] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:5:0) after 9m45s
[01:58:40.243] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:5:0)
[01:58:40.263] Build status: SCHEDULED
[01:58:40.263] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:6:0) after 8m1s
[02:06:41.385] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:6:0)
[02:06:41.430] Build status: SCHEDULED
[02:06:41.430] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:7:0) after 2m34s
[02:09:15.445] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:7:0)
[02:09:15.468] Build status: SCHEDULED
[02:09:15.468] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:8:0) after 5m18s
[02:14:33.484] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:8:0)
[02:14:33.509] Build status: SCHEDULED
[02:14:33.509] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:9:0) after 1m10s
[02:15:43.633] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:9:0)
[02:15:43.648] Build status: SCHEDULED
[02:15:43.648] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:10:0) after 2m3s
[02:17:46.771] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:10:0)
[02:17:46.799] Build status: SCHEDULED
[02:17:46.800] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:11:0) after 6m53s
[02:24:39.820] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:11:0)
[02:24:39.968] Build status: SCHEDULED
[02:24:39.968] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:12:0) after 3m47s
[02:28:27.040] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:12:0)
[02:28:27.075] Build status: SCHEDULED
[02:28:27.075] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:13:0) after 2m7s
[02:30:34.101] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:13:0)
[02:30:34.127] Build status: SCHEDULED
[02:30:34.127] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:14:0) after 4m2s
[02:34:36.236] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:14:0)
[02:34:36.262] Build status: SCHEDULED
[02:34:36.262] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:15:0) after 1m24s
[02:36:00.405] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:15:0)
[02:36:00.577] Build status: SCHEDULED
[02:36:00.577] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:16:0) after 5m10s
[02:41:10.863] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:16:0)
[02:41:10.972] Build status: SCHEDULED
[02:41:10.972] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:17:0) after 4m7s
[02:45:17.987] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:17:0)
[02:45:18.017] Build status: SCHEDULED
[02:45:18.017] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:18:0) after 2m44s
[02:48:02.044] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:18:0)
[02:48:02.185] Build status: SCHEDULED
[02:48:02.185] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:19:0) after 6m31s
[02:54:33.575] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:19:0)
[02:54:33.609] Build status: SCHEDULED
[02:54:33.609] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:20:0) after 2m18s
[02:56:51.838] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:20:0)
[02:56:51.860] Build status: SCHEDULED
[02:56:51.860] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:21:0) after 5m48s
[03:02:40.306] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:21:0)
[03:02:40.334] Build status: SCHEDULED
[03:02:40.334] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:22:0) after 5m34s
[03:08:14.355] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:22:0)
[03:08:14.379] Build status: SCHEDULED
[03:08:14.379] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:23:0) after 7m7s
[03:15:21.470] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:23:0)
[03:15:21.496] Build status: SCHEDULED
[03:15:21.496] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:24:0) after 8m49s
[03:24:10.566] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:24:0)
[03:24:10.587] Build status: SCHEDULED
[03:24:10.588] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:25:0) after 7m11s
[03:31:21.606] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:25:0)
[03:31:21.709] Build status: SCHEDULED
[03:31:21.709] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:26:0) after 3m10s
[03:34:31.731] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:26:0)
[03:34:31.770] Build status: SCHEDULED
[03:34:31.770] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:27:0) after 3m34s
[03:38:05.930] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:27:0)
[03:38:05.960] Build status: SCHEDULED
[03:38:05.960] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:28:0) after 6m24s
[03:44:29.987] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:28:0)
[03:44:30.010] Build status: SCHEDULED
[03:44:30.010] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:29:0) after 7m15s
[03:51:45.034] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:29:0)
[03:51:45.061] Build status: SCHEDULED
[03:51:45.061] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:30:0) after 7m52s
[03:55:17.600] Received PubSub notification, asking Buildbucket for the build status
[03:55:17.618] Build status: STARTED
[03:59:37.244] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:30:0)
[03:59:37.266] Build status: STARTED
[03:59:37.266] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:32:0) after 3m35s
[04:03:12.291] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:32:0)
[04:03:12.312] Build status: STARTED
[04:03:12.312] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:33:0) after 4m29s
[04:07:41.429] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:33:0)
[04:07:41.464] Build status: STARTED
[04:07:41.464] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:34:0) after 1m6s
[04:08:47.543] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:34:0)
[04:08:47.562] Build status: STARTED
[04:08:47.562] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:35:0) after 4m33s
[04:13:20.586] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:35:0)
[04:13:20.664] Build status: STARTED
[04:13:20.664] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:36:0) after 6m18s
[04:19:39.046] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:36:0)
[04:19:39.071] Build status: STARTED
[04:19:39.071] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:37:0) after 9m48s
[04:29:27.203] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:37:0)
[04:29:27.225] Build status: STARTED
[04:29:27.225] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:38:0) after 6m2s
[04:35:29.267] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:38:0)
[04:35:29.286] Build status: STARTED
[04:35:29.286] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:39:0) after 6m44s
[04:42:13.312] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:39:0)
[04:42:13.331] Build status: STARTED
[04:42:13.331] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:40:0) after 4m25s
[04:46:38.396] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:40:0)
[04:46:38.418] Build status: STARTED
[04:46:38.418] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:41:0) after 5m34s
[04:52:12.451] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:41:0)
[04:52:12.509] Build status: STARTED
[04:52:12.509] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:42:0) after 7m4s
[04:59:16.561] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:42:0)
[04:59:16.591] Build status: STARTED
[04:59:16.591] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:43:0) after 5m21s
[05:04:37.819] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:43:0)
[05:04:37.844] Build status: STARTED
[05:04:37.844] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:44:0) after 7m5s
[05:11:42.902] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:44:0)
[05:11:42.935] Build status: STARTED
[05:11:42.935] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:45:0) after 8m13s
[05:19:56.165] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:45:0)
[05:19:56.184] Build status: STARTED
[05:19:56.184] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:46:0) after 4m40s
[05:24:36.304] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:46:0)
[05:24:36.333] Build status: STARTED
[05:24:36.333] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:47:0) after 5m48s
[05:30:24.363] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:47:0)
[05:30:24.416] Build status: STARTED
[05:30:24.416] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:48:0) after 9m5s
[05:39:29.539] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:48:0)
[05:39:29.565] Build status: STARTED
[05:39:29.565] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:49:0) after 3m43s
[05:43:12.590] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:49:0)
[05:43:12.680] Build status: STARTED
[05:43:12.680] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:50:0) after 5m11s
[05:48:23.824] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:50:0)
[05:48:23.865] Build status: STARTED
[05:48:23.865] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:51:0) after 9m59s
[05:58:22.927] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:51:0)
[05:58:22.971] Build status: STARTED
[05:58:22.971] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:52:0) after 9m57s
[06:08:20.050] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:52:0)
[06:08:20.071] Build status: STARTED
[06:08:20.071] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:53:0) after 4m59s
[06:13:19.156] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:53:0)
[06:13:19.171] Build status: STARTED
[06:13:19.171] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:54:0) after 2m0s
[06:15:19.214] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:54:0)
[06:15:19.230] Build status: STARTED
[06:15:19.230] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:55:0) after 4m42s
[06:20:01.254] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:55:0)
[06:20:01.271] Build status: STARTED
[06:20:01.271] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:56:0) after 4m46s
[06:24:47.292] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:56:0)
[06:24:47.308] Build status: STARTED
[06:24:47.308] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:57:0) after 1m2s
[06:25:49.333] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:57:0)
[06:25:49.351] Build status: STARTED
[06:25:49.351] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:58:0) after 8m32s
[06:34:21.551] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:58:0)
[06:34:21.571] Build status: STARTED
[06:34:21.571] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:59:0) after 8m6s
[06:42:27.586] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:59:0)
[06:42:27.671] Build status: STARTED
[06:42:27.671] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:60:0) after 5m48s
[06:48:15.801] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:60:0)
[06:48:15.820] Build status: STARTED
[06:48:15.820] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:61:0) after 8m24s
[06:56:39.853] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:61:0)
[06:56:39.873] Build status: STARTED
[06:56:39.873] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:62:0) after 7m47s
[07:04:26.909] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:62:0)
[07:04:26.929] Build status: STARTED
[07:04:26.929] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:63:0) after 3m48s
[07:08:14.992] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:63:0)
[07:08:15.016] Build status: STARTED
[07:08:15.016] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:64:0) after 9m28s
[07:17:43.054] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:64:0)
[07:17:43.074] Build status: STARTED
[07:17:43.074] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:65:0) after 7m58s
[07:25:41.148] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:65:0)
[07:25:41.172] Build status: STARTED
[07:25:41.172] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:66:0) after 2m20s
[07:28:01.188] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:66:0)
[07:28:01.212] Build status: STARTED
[07:28:01.212] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:67:0) after 6m56s
[07:34:57.357] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:67:0)
[07:34:57.372] Build status: STARTED
[07:34:57.372] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:68:0) after 6m36s
[07:41:33.865] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:68:0)
[07:41:33.898] Build status: STARTED
[07:41:33.899] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:69:0) after 1m32s
[07:43:05.909] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:69:0)
[07:43:05.924] Build status: STARTED
[07:43:05.924] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:70:0) after 8m20s
[07:51:25.900] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:70:0)
[07:51:25.959] Build status: STARTED
[07:51:25.959] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:71:0) after 9m37s
[08:01:02.989] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:71:0)
[08:01:03.024] Build status: STARTED
[08:01:03.024] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:72:0) after 5m59s
[08:07:02.562] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:72:0)
[08:07:02.587] Build status: STARTED
[08:07:02.587] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:73:0) after 6m12s
[08:13:14.873] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:73:0)
[08:13:14.896] Build status: STARTED
[08:13:14.896] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:74:0) after 8m19s
[08:21:33.918] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:74:0)
[08:21:33.936] Build status: STARTED
[08:21:33.936] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:75:0) after 1m52s
[08:23:25.963] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:75:0)
[08:23:25.978] Build status: STARTED
[08:23:25.978] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:76:0) after 4m36s
[08:28:02.167] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:76:0)
[08:28:02.193] Build status: STARTED
[08:28:02.193] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:77:0) after 2m48s
[08:30:50.223] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:77:0)
[08:30:50.289] Build status: STARTED
[08:30:50.290] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:78:0) after 3m12s
[08:34:02.374] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:78:0)
[08:34:02.396] Build status: STARTED
[08:34:02.396] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:79:0) after 6m42s
[08:40:44.419] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:79:0)
[08:40:44.447] Build status: STARTED
[08:40:44.447] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:80:0) after 1m3s
[08:41:47.660] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:80:0)
[08:41:47.675] Build status: STARTED
[08:41:47.675] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:81:0) after 6m9s
[08:47:56.847] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:81:0)
[08:47:56.864] Build status: STARTED
[08:47:56.864] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:82:0) after 6m51s
[08:54:47.936] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:82:0)
[08:54:47.986] Build status: STARTED
[08:54:47.986] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:83:0) after 3m34s
[08:58:22.168] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:83:0)
[08:58:22.188] Build status: STARTED
[08:58:22.188] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:84:0) after 5m11s
[09:03:33.218] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:84:0)
[09:03:33.240] Build status: STARTED
[09:03:33.240] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:85:0) after 4m49s
[09:08:22.271] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:85:0)
[09:08:22.291] Build status: STARTED
[09:08:22.291] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:86:0) after 9m35s
[09:17:57.325] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:86:0)
[09:17:57.346] Build status: STARTED
[09:17:57.346] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:87:0) after 7m45s
[09:25:42.657] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:87:0)
[09:25:42.681] Build status: STARTED
[09:25:42.681] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:88:0) after 7m34s
[09:33:16.768] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:88:0)
[09:33:16.785] Build status: STARTED
[09:33:16.785] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:89:0) after 5m3s
[09:38:19.813] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:89:0)
[09:38:19.829] Build status: STARTED
[09:38:19.829] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:90:0) after 8m15s
[09:46:34.895] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:90:0)
[09:46:34.912] Build status: STARTED
[09:46:34.912] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:91:0) after 8m1s
[09:54:35.935] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:91:0)
[09:54:35.953] Build status: STARTED
[09:54:35.953] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:92:0) after 3m42s
[09:58:17.930] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:92:0)
[09:58:17.947] Build status: STARTED
[09:58:17.947] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:93:0) after 7m23s
[10:05:41.452] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:93:0)
[10:05:41.468] Build status: STARTED
[10:05:41.468] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:94:0) after 4m33s
[10:10:14.855] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:94:0)
[10:10:14.875] Build status: STARTED
[10:10:14.875] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:95:0) after 4m3s
[10:14:18.032] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:95:0)
[10:14:18.140] Build status: STARTED
[10:14:18.140] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:96:0) after 2m49s
[10:17:07.164] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:96:0)
[10:17:07.181] Build status: STARTED
[10:17:07.181] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:97:0) after 8m23s
[10:25:30.248] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:97:0)
[10:25:30.272] Build status: STARTED
[10:25:30.273] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:98:0) after 4m8s
[10:29:38.291] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:98:0)
[10:29:38.434] Build status: STARTED
[10:29:38.434] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:99:0) after 8m50s
[10:38:28.610] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:99:0)
[10:38:28.630] Build status: STARTED
[10:38:28.630] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:100:0) after 7m11s
[10:45:39.891] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:100:0)
[10:45:39.911] Build status: STARTED
[10:45:39.911] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:101:0) after 7m11s
[10:52:51.037] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:101:0)
[10:52:51.060] Build status: STARTED
[10:52:51.060] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:102:0) after 3m53s
[10:56:44.209] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:102:0)
[10:56:44.231] Build status: STARTED
[10:56:44.231] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:103:0) after 5m37s
[11:02:21.295] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:103:0)
[11:02:21.313] Build status: STARTED
[11:02:21.313] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:104:0) after 8m15s
[11:10:36.532] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:104:0)
[11:10:36.569] Build status: STARTED
[11:10:36.569] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:105:0) after 1m19s
[11:11:55.641] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:105:0)
[11:11:55.689] Build status: STARTED
[11:11:55.689] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:106:0) after 4m40s
[11:16:35.792] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:106:0)
[11:16:35.837] Build status: STARTED
[11:16:35.837] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:107:0) after 2m23s
[11:18:58.950] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:107:0)
[11:18:59.027] Build status: STARTED
[11:18:59.027] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:108:0) after 6m38s
[11:25:37.211] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:108:0)
[11:25:37.276] Build status: STARTED
[11:25:37.276] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:109:0) after 8m56s
[11:34:33.403] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:109:0)
[11:34:33.431] Build status: STARTED
[11:34:33.431] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:110:0) after 9m4s
[11:43:37.474] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:110:0)
[11:43:37.497] Build status: STARTED
[11:43:37.497] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:111:0) after 6m27s
[11:50:04.608] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:111:0)
[11:50:04.629] Build status: STARTED
[11:50:04.629] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:112:0) after 3m45s
[11:53:49.658] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:112:0)
[11:53:49.686] Build status: STARTED
[11:53:49.686] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:113:0) after 7m35s
[12:01:24.912] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:113:0)
[12:01:24.935] Build status: STARTED
[12:01:24.935] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:114:0) after 2m22s
[12:03:47.037] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:114:0)
[12:03:47.059] Build status: STARTED
[12:03:47.059] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:115:0) after 7m0s
[12:10:47.145] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:115:0)
[12:10:47.166] Build status: STARTED
[12:10:47.166] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:116:0) after 7m43s
[12:18:30.192] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:116:0)
[12:18:30.246] Build status: STARTED
[12:18:30.246] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:117:0) after 8m3s
[12:26:33.312] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:117:0)
[12:26:33.324] Build status: STARTED
[12:26:33.324] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:118:0) after 7m31s
[12:34:04.399] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:118:0)
[12:34:04.428] Build status: STARTED
[12:34:04.428] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:119:0) after 1m20s
[12:35:24.448] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:119:0)
[12:35:24.468] Build status: STARTED
[12:35:24.468] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:120:0) after 7m34s
[12:42:58.497] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:120:0)
[12:42:58.521] Build status: STARTED
[12:42:58.521] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:121:0) after 6m11s
[12:49:09.543] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:121:0)
[12:49:09.561] Build status: STARTED
[12:49:09.561] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:122:0) after 6m54s
[12:56:03.703] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:122:0)
[12:56:03.717] Build status: STARTED
[12:56:03.717] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:123:0) after 4m53s
[13:00:56.746] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:123:0)
[13:00:56.773] Build status: STARTED
[13:00:56.774] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:124:0) after 7m53s
[13:08:49.792] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:124:0)
[13:08:49.815] Build status: STARTED
[13:08:49.815] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:125:0) after 9m59s
[13:18:48.858] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:125:0)
[13:18:48.910] Build status: STARTED
[13:18:48.910] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:126:0) after 6m27s
[13:25:15.970] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:126:0)
[13:25:16.009] Build status: STARTED
[13:25:16.009] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:127:0) after 2m12s
[13:27:28.226] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:127:0)
[13:27:28.248] Build status: STARTED
[13:27:28.248] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:128:0) after 7m50s
[13:35:18.325] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:128:0)
[13:35:18.356] Build status: STARTED
[13:35:18.356] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:129:0) after 9m15s
[13:44:33.386] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:129:0)
[13:44:33.443] Build status: STARTED
[13:44:33.443] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:130:0) after 3m45s
[13:48:18.470] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:130:0)
[13:48:18.487] Build status: STARTED
[13:48:18.487] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:131:0) after 7m36s
[13:55:54.521] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:131:0)
[13:55:54.545] Build status: STARTED
[13:55:54.546] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:132:0) after 9m5s
[14:04:59.634] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:132:0)
[14:04:59.663] Build status: STARTED
[14:04:59.663] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:133:0) after 1m20s
[14:06:19.691] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:133:0)
[14:06:19.711] Build status: STARTED
[14:06:19.711] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:134:0) after 8m48s
[14:15:07.738] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:134:0)
[14:15:07.757] Build status: STARTED
[14:15:07.757] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:135:0) after 7m35s
[14:22:42.775] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:135:0)
[14:22:42.798] Build status: STARTED
[14:22:42.798] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:136:0) after 8m13s
[14:30:55.860] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:136:0)
[14:30:55.885] Build status: STARTED
[14:30:55.885] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:137:0) after 9m15s
[14:40:10.906] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:137:0)
[14:40:10.929] Build status: STARTED
[14:40:10.929] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:138:0) after 7m43s
[14:47:54.007] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:138:0)
[14:47:54.026] Build status: STARTED
[14:47:54.026] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:139:0) after 5m23s
[14:53:17.074] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:139:0)
[14:53:17.090] Build status: STARTED
[14:53:17.090] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:140:0) after 8m1s
[15:01:18.122] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:140:0)
[15:01:18.145] Build status: STARTED
[15:01:18.145] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:141:0) after 8m34s
[15:09:52.233] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:141:0)
[15:09:52.288] Build status: STARTED
[15:09:52.288] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:142:0) after 4m41s
[15:14:33.306] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:142:0)
[15:14:33.367] Build status: STARTED
[15:14:33.367] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:143:0) after 2m44s
[15:17:17.409] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:143:0)
[15:17:17.429] Build status: STARTED
[15:17:17.429] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:144:0) after 1m57s
[15:19:14.450] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:144:0)
[15:19:14.469] Build status: STARTED
[15:19:14.469] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:145:0) after 8m30s
[15:27:44.504] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:145:0)
[15:27:44.526] Build status: STARTED
[15:27:44.526] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:146:0) after 7m59s
[15:35:43.584] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:146:0)
[15:35:43.603] Build status: STARTED
[15:35:43.603] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:147:0) after 4m31s
[15:40:14.619] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:147:0)
[15:40:14.649] Build status: STARTED
[15:40:14.649] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:148:0) after 1m52s
[15:42:06.670] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:148:0)
[15:42:06.723] Build status: STARTED
[15:42:06.723] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:149:0) after 1m8s
[15:43:14.746] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:149:0)
[15:43:14.761] Build status: STARTED
[15:43:14.761] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:150:0) after 7m54s
[15:51:08.892] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:150:0)
[15:51:08.938] Build status: STARTED
[15:51:08.938] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:151:0) after 7m41s
[15:58:49.930] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:151:0)
[15:58:49.953] Build status: STARTED
[15:58:49.953] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:152:0) after 1m4s
[15:59:53.980] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:152:0)
[15:59:54.005] Build status: STARTED
[15:59:54.005] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:153:0) after 3m19s
[16:03:13.034] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:153:0)
[16:03:13.053] Build status: STARTED
[16:03:13.053] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:154:0) after 3m3s
[16:06:16.082] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:154:0)
[16:06:16.140] Build status: STARTED
[16:06:16.140] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:155:0) after 2m4s
[16:08:20.162] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:155:0)
[16:08:20.178] Build status: STARTED
[16:08:20.179] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:156:0) after 4m43s
[16:13:03.254] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:156:0)
[16:13:03.268] Build status: STARTED
[16:13:03.268] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:157:0) after 7m20s
[16:20:23.478] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:157:0)
[16:20:23.496] Build status: STARTED
[16:20:23.496] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:158:0) after 8m10s
[16:28:33.583] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:158:0)
[16:28:33.610] Build status: STARTED
[16:28:33.610] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:159:0) after 3m34s
[16:32:07.636] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:159:0)
[16:32:07.653] Build status: STARTED
[16:32:07.653] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:160:0) after 9m24s
[16:41:31.730] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:160:0)
[16:41:31.750] Build status: STARTED
[16:41:31.750] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:161:0) after 7m26s
[16:48:57.770] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:161:0)
[16:48:57.886] Build status: STARTED
[16:48:57.886] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:162:0) after 4m47s
[16:53:44.885] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:162:0)
[16:53:44.905] Build status: STARTED
[16:53:44.905] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:163:0) after 1m21s
[16:55:05.989] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:163:0)
[16:55:06.007] Build status: STARTED
[16:55:06.008] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:164:0) after 7m14s
[17:02:20.017] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:164:0)
[17:02:20.037] Build status: STARTED
[17:02:20.037] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:165:0) after 1m5s
[17:03:25.067] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:165:0)
[17:03:25.154] Build status: STARTED
[17:03:25.154] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:166:0) after 3m12s
[17:06:37.180] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:166:0)
[17:06:37.198] Build status: STARTED
[17:06:37.198] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:167:0) after 1m34s
[17:08:11.298] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:167:0)
[17:08:11.320] Build status: STARTED
[17:08:11.320] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:168:0) after 7m51s
[17:16:02.371] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:168:0)
[17:16:02.391] Build status: STARTED
[17:16:02.391] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:169:0) after 4m12s
[17:20:14.442] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:169:0)
[17:20:14.470] Build status: STARTED
[17:20:14.470] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:170:0) after 7m55s
[17:28:09.494] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:170:0)
[17:28:09.565] Build status: STARTED
[17:28:09.565] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:171:0) after 1m25s
[17:29:34.590] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:171:0)
[17:29:34.623] Build status: STARTED
[17:29:34.623] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:172:0) after 4m9s
[17:33:43.699] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:172:0)
[17:33:43.721] Build status: STARTED
[17:33:43.721] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:173:0) after 1m8s
[17:34:51.748] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:173:0)
[17:34:51.777] Build status: STARTED
[17:34:51.777] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:174:0) after 1m42s
[17:36:33.831] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:174:0)
[17:36:33.859] Build status: STARTED
[17:36:33.859] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:175:0) after 2m57s
[17:39:30.886] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:175:0)
[17:39:30.903] Build status: STARTED
[17:39:30.903] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:176:0) after 6m14s
[17:45:44.918] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:176:0)
[17:45:44.933] Build status: STARTED
[17:45:44.933] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:177:0) after 8m47s
[17:54:32.020] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:177:0)
[17:54:32.087] Build status: STARTED
[17:54:32.087] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:178:0) after 9m42s
[18:04:14.135] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:178:0)
[18:04:14.157] Build status: STARTED
[18:04:14.157] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:179:0) after 5m22s
[18:09:36.223] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:179:0)
[18:09:36.245] Build status: STARTED
[18:09:36.245] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:180:0) after 6m10s
[18:15:46.270] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:180:0)
[18:15:46.292] Build status: STARTED
[18:15:46.292] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:181:0) after 9m33s
[18:25:19.399] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:181:0)
[18:25:19.419] Build status: STARTED
[18:25:19.419] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:182:0) after 1m20s
[18:26:39.442] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:182:0)
[18:26:39.468] Build status: STARTED
[18:26:39.468] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:183:0) after 2m5s
[18:28:44.442] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:183:0)
[18:28:44.459] Build status: STARTED
[18:28:44.459] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:184:0) after 6m7s
[18:34:51.491] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:184:0)
[18:34:51.549] Build status: STARTED
[18:34:51.549] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:185:0) after 3m17s
[18:38:08.572] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:185:0)
[18:38:08.593] Build status: STARTED
[18:38:08.593] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:186:0) after 3m59s
[18:42:07.689] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:186:0)
[18:42:07.714] Build status: STARTED
[18:42:07.714] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:187:0) after 1m25s
[18:43:32.822] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:187:0)
[18:43:32.845] Build status: STARTED
[18:43:32.845] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:188:0) after 4m41s
[18:48:13.919] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:188:0)
[18:48:13.970] Build status: STARTED
[18:48:13.970] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:189:0) after 4m47s
[18:53:01.032] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:189:0)
[18:53:01.054] Build status: STARTED
[18:53:01.054] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:190:0) after 2m41s
[18:55:42.077] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:190:0)
[18:55:42.170] Build status: STARTED
[18:55:42.170] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:191:0) after 6m22s
[19:02:04.285] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:191:0)
[19:02:04.310] Build status: STARTED
[19:02:04.310] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:192:0) after 5m8s
[19:07:12.317] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:192:0)
[19:07:12.339] Build status: STARTED
[19:07:12.339] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:193:0) after 3m59s
[19:11:11.395] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:193:0)
[19:11:11.458] Build status: STARTED
[19:11:11.458] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:194:0) after 7m20s
[19:18:31.564] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:194:0)
[19:18:31.594] Build status: STARTED
[19:18:31.594] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:195:0) after 2m18s
[19:20:49.628] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:195:0)
[19:20:49.681] Build status: STARTED
[19:20:49.681] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:196:0) after 3m50s
[19:24:39.724] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:196:0)
[19:24:39.747] Build status: STARTED
[19:24:39.747] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:197:0) after 7m39s
[19:32:18.751] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:197:0)
[19:32:18.861] Build status: STARTED
[19:32:18.861] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:198:0) after 4m5s
[19:36:23.961] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:198:0)
[19:36:23.986] Build status: STARTED
[19:36:23.986] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:199:0) after 2m21s
[19:38:45.303] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:199:0)
[19:38:45.357] Build status: STARTED
[19:38:45.357] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:200:0) after 2m53s
[19:41:38.433] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:200:0)
[19:41:38.460] Build status: STARTED
[19:41:38.460] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:201:0) after 1m28s
[19:43:06.485] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:201:0)
[19:43:06.507] Build status: STARTED
[19:43:06.507] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:202:0) after 1m1s
[19:44:07.532] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:202:0)
[19:44:07.549] Build status: STARTED
[19:44:07.549] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:203:0) after 3m50s
[19:47:57.574] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:203:0)
[19:47:57.602] Build status: STARTED
[19:47:57.602] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:204:0) after 3m27s
[19:51:24.665] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:204:0)
[19:51:24.706] Build status: STARTED
[19:51:24.706] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:205:0) after 7m53s
[19:59:17.730] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:205:0)
[19:59:17.747] Build status: STARTED
[19:59:17.747] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:206:0) after 8m13s
[20:07:30.773] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:206:0)
[20:07:30.792] Build status: STARTED
[20:07:30.792] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:207:0) after 2m5s
[20:09:35.810] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:207:0)
[20:09:35.826] Build status: STARTED
[20:09:35.827] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:208:0) after 3m28s
[20:13:03.933] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:208:0)
[20:13:03.954] Build status: STARTED
[20:13:03.954] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:209:0) after 3m15s
[20:16:18.982] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:209:0)
[20:16:19.020] Build status: STARTED
[20:16:19.020] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:210:0) after 9m18s
[20:25:37.048] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:210:0)
[20:25:37.073] Build status: STARTED
[20:25:37.073] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:211:0) after 9m12s
[20:34:49.101] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:211:0)
[20:34:49.127] Build status: STARTED
[20:34:49.127] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:212:0) after 7m55s
[20:42:44.156] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:212:0)
[20:42:44.208] Build status: STARTED
[20:42:44.208] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8876741461447171088:213:0) after 5m25s
[20:43:18.405] Received PubSub notification, asking Buildbucket for the build status
[20:43:18.421] Build:
{
"id": "8711311399475527905",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "CrWinAsan"
},
"number": 19049,
"createdBy": "project:chromium",
"createTime": "2025-06-23T01:44:38.311943549Z",
"startTime": "2025-06-23T03:55:17.254203354Z",
"endTime": "2025-06-23T20:43:14.822597994Z",
"updateTime": "2025-06-23T20:43:14.822597994Z",
"status": "INFRA_FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e319f595e7e821546d0891a6f0b962e90c3be27e",
"ref": "refs/heads/main"
}
}
}
[20:43:18.421] Invocation finished in 18h58m41.374060342s with status FAILED