[13:08:39.483] New invocation is queued and will start shortly
[13:08:40.681] Starting the invocation (attempt 1)
[13:08:40.710] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/49eb4e097c1d2a92b8cc4164f24c214e15c21ced"
[13:08:40.710] Popped gitiles commit info from properties and tags
[13:08:40.710] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:08:40.710] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:08:40.710] Buildbucket request:
{
"requestId": "8944736747104865648",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "CrWinAsan"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "49eb4e097c1d2a92b8cc4164f24c214e15c21ced",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8944736747104865648"
},
{
"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"
}
}
[13:08:41.107] Scheduled build:
{
"id": "8779306685102655505",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "CrWinAsan"
},
"number": 11475,
"createdBy": "project:chromium",
"createTime": "2023-06-03T13:08:40.771202500Z",
"updateTime": "2023-06-03T13:08:40.771202500Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "49eb4e097c1d2a92b8cc4164f24c214e15c21ced",
"ref": "refs/heads/main"
}
}
}
[13:08:41.107] Task URL: https://cr-buildbucket.appspot.com/build/8779306685102655505
[13:08:41.107] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:2:0) after 9m50s
[13:08:59.960] Received PubSub notification, asking Buildbucket for the build status
[13:08:59.980] Build status: STARTED
[13:18:31.544] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:2:0)
[13:18:31.570] Build status: STARTED
[13:18:31.570] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:4:0) after 5m13s
[13:23:44.985] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:4:0)
[13:23:45.002] Build status: STARTED
[13:23:45.002] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:5:0) after 8m57s
[13:32:42.021] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:5:0)
[13:32:42.059] Build status: STARTED
[13:32:42.059] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:6:0) after 9m33s
[13:42:15.078] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:6:0)
[13:42:15.096] Build status: STARTED
[13:42:15.096] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:7:0) after 5m44s
[13:47:59.123] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:7:0)
[13:47:59.145] Build status: STARTED
[13:47:59.145] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:8:0) after 8m58s
[13:56:57.168] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:8:0)
[13:56:57.186] Build status: STARTED
[13:56:57.186] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:9:0) after 1m12s
[13:58:09.495] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:9:0)
[13:58:09.525] Build status: STARTED
[13:58:09.525] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:10:0) after 4m34s
[14:02:43.773] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:10:0)
[14:02:43.804] Build status: STARTED
[14:02:43.804] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:11:0) after 5m2s
[14:07:46.008] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:11:0)
[14:07:46.032] Build status: STARTED
[14:07:46.032] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:12:0) after 1m39s
[14:09:25.746] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:12:0)
[14:09:25.766] Build status: STARTED
[14:09:25.766] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:13:0) after 1m0s
[14:10:25.790] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:13:0)
[14:10:25.806] Build status: STARTED
[14:10:25.806] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:14:0) after 4m3s
[14:14:28.826] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:14:0)
[14:14:28.851] Build status: STARTED
[14:14:28.851] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:15:0) after 2m34s
[14:17:02.857] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:15:0)
[14:17:02.876] Build status: STARTED
[14:17:02.876] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:16:0) after 3m31s
[14:20:34.592] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:16:0)
[14:20:34.622] Build status: STARTED
[14:20:34.622] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:17:0) after 4m33s
[14:25:07.861] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:17:0)
[14:25:07.881] Build status: STARTED
[14:25:07.881] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:18:0) after 4m30s
[14:29:37.899] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:18:0)
[14:29:37.917] Build status: STARTED
[14:29:37.917] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:19:0) after 6m24s
[14:36:02.166] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:19:0)
[14:36:02.189] Build status: STARTED
[14:36:02.189] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:20:0) after 6m46s
[14:42:48.211] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:20:0)
[14:42:48.228] Build status: STARTED
[14:42:48.228] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:21:0) after 4m55s
[14:47:43.407] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:21:0)
[14:47:43.454] Build status: STARTED
[14:47:43.454] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:22:0) after 4m33s
[14:52:16.473] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:22:0)
[14:52:16.492] Build status: STARTED
[14:52:16.492] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:23:0) after 5m29s
[14:57:45.519] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:23:0)
[14:57:45.559] Build status: STARTED
[14:57:45.559] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:24:0) after 8m53s
[15:06:38.737] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:24:0)
[15:06:38.764] Build status: STARTED
[15:06:38.764] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:25:0) after 5m29s
[15:12:07.786] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:25:0)
[15:12:07.816] Build status: STARTED
[15:12:07.816] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:26:0) after 3m38s
[15:15:45.940] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:26:0)
[15:15:45.962] Build status: STARTED
[15:15:45.962] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:27:0) after 5m36s
[15:21:22.191] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:27:0)
[15:21:22.210] Build status: STARTED
[15:21:22.210] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:28:0) after 8m49s
[15:30:11.419] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:28:0)
[15:30:11.440] Build status: STARTED
[15:30:11.440] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:29:0) after 7m12s
[15:37:23.468] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:29:0)
[15:37:23.489] Build status: STARTED
[15:37:23.489] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:30:0) after 3m31s
[15:40:54.527] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:30:0)
[15:40:54.545] Build status: STARTED
[15:40:54.545] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:31:0) after 2m20s
[15:43:14.740] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:31:0)
[15:43:14.759] Build status: STARTED
[15:43:14.759] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:32:0) after 8m47s
[15:52:01.821] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:32:0)
[15:52:01.841] Build status: STARTED
[15:52:01.841] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:33:0) after 6m58s
[15:58:59.836] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:33:0)
[15:58:59.856] Build status: STARTED
[15:58:59.856] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:34:0) after 5m56s
[16:04:55.884] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:34:0)
[16:04:56.068] Build status: STARTED
[16:04:56.068] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:35:0) after 7m30s
[16:12:26.084] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:35:0)
[16:12:26.111] Build status: STARTED
[16:12:26.111] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:36:0) after 2m54s
[16:15:20.349] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:36:0)
[16:15:20.372] Build status: STARTED
[16:15:20.372] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:37:0) after 9m33s
[16:24:53.387] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:37:0)
[16:24:53.405] Build status: STARTED
[16:24:53.405] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:38:0) after 1m22s
[16:26:15.427] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:38:0)
[16:26:15.446] Build status: STARTED
[16:26:15.446] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:39:0) after 8m58s
[16:35:13.528] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:39:0)
[16:35:13.550] Build status: STARTED
[16:35:13.550] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:40:0) after 7m25s
[16:42:38.799] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:40:0)
[16:42:38.816] Build status: STARTED
[16:42:38.817] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:41:0) after 7m1s
[16:49:39.800] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:41:0)
[16:49:39.817] Build status: STARTED
[16:49:39.817] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:42:0) after 2m42s
[16:52:21.845] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:42:0)
[16:52:21.878] Build status: STARTED
[16:52:21.878] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:43:0) after 5m35s
[16:57:56.895] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:43:0)
[16:57:56.933] Build status: STARTED
[16:57:56.933] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:44:0) after 7m3s
[17:04:59.956] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:44:0)
[17:04:59.980] Build status: STARTED
[17:04:59.980] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:45:0) after 9m26s
[17:14:25.999] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:45:0)
[17:14:26.017] Build status: STARTED
[17:14:26.017] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:46:0) after 4m28s
[17:18:54.352] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:46:0)
[17:18:54.390] Build status: STARTED
[17:18:54.390] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:47:0) after 8m59s
[17:27:53.380] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:47:0)
[17:27:53.406] Build status: STARTED
[17:27:53.406] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:48:0) after 9m59s
[17:37:52.632] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:48:0)
[17:37:52.649] Build status: STARTED
[17:37:52.649] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:49:0) after 3m44s
[17:41:36.680] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:49:0)
[17:41:36.702] Build status: STARTED
[17:41:36.702] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:50:0) after 8m49s
[17:50:25.729] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:50:0)
[17:50:25.747] Build status: STARTED
[17:50:25.747] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:51:0) after 7m10s
[17:57:35.763] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:51:0)
[17:57:35.782] Build status: STARTED
[17:57:35.782] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:52:0) after 4m43s
[18:02:18.799] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:52:0)
[18:02:18.822] Build status: STARTED
[18:02:18.822] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:53:0) after 4m34s
[18:06:52.866] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:53:0)
[18:06:53.026] Build status: STARTED
[18:06:53.027] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:54:0) after 6m51s
[18:13:44.073] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:54:0)
[18:13:44.096] Build status: STARTED
[18:13:44.096] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:55:0) after 6m29s
[18:20:13.124] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:55:0)
[18:20:13.146] Build status: STARTED
[18:20:13.146] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:56:0) after 8m53s
[18:29:06.166] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:56:0)
[18:29:06.182] Build status: STARTED
[18:29:06.182] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:57:0) after 1m49s
[18:30:55.270] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:57:0)
[18:30:55.305] Build status: STARTED
[18:30:55.305] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:58:0) after 2m57s
[18:33:52.326] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:58:0)
[18:33:52.344] Build status: STARTED
[18:33:52.344] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:59:0) after 7m56s
[18:41:48.462] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:59:0)
[18:41:48.484] Build status: STARTED
[18:41:48.484] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:60:0) after 7m46s
[18:49:34.503] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:60:0)
[18:49:34.537] Build status: STARTED
[18:49:34.537] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:61:0) after 2m29s
[18:52:03.563] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:61:0)
[18:52:03.580] Build status: STARTED
[18:52:03.580] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:62:0) after 3m56s
[18:55:59.647] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:62:0)
[18:55:59.678] Build status: STARTED
[18:55:59.678] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:63:0) after 8m28s
[19:04:27.800] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:63:0)
[19:04:27.822] Build status: STARTED
[19:04:27.823] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:64:0) after 3m15s
[19:07:42.969] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:64:0)
[19:07:42.994] Build status: STARTED
[19:07:42.994] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:65:0) after 4m32s
[19:12:15.156] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:65:0)
[19:12:15.182] Build status: STARTED
[19:12:15.182] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:66:0) after 5m43s
[19:17:58.310] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:66:0)
[19:17:58.336] Build status: STARTED
[19:17:58.336] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:67:0) after 9m1s
[19:26:59.356] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:67:0)
[19:26:59.402] Build status: STARTED
[19:26:59.402] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:68:0) after 4m57s
[19:31:56.532] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:68:0)
[19:31:56.550] Build status: STARTED
[19:31:56.550] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:69:0) after 6m38s
[19:38:34.667] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:69:0)
[19:38:34.690] Build status: STARTED
[19:38:34.690] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:70:0) after 5m21s
[19:43:55.710] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:70:0)
[19:43:55.726] Build status: STARTED
[19:43:55.726] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:71:0) after 5m8s
[19:49:03.941] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:71:0)
[19:49:04.043] Build status: STARTED
[19:49:04.043] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:72:0) after 9m38s
[19:58:42.062] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:72:0)
[19:58:42.078] Build status: STARTED
[19:58:42.078] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:73:0) after 2m39s
[20:01:21.254] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:73:0)
[20:01:21.277] Build status: STARTED
[20:01:21.277] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:74:0) after 3m50s
[20:05:11.347] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:74:0)
[20:05:11.366] Build status: STARTED
[20:05:11.366] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:75:0) after 5m28s
[20:10:39.690] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:75:0)
[20:10:39.708] Build status: STARTED
[20:10:39.708] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:76:0) after 4m2s
[20:14:41.777] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:76:0)
[20:14:41.800] Build status: STARTED
[20:14:41.800] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:77:0) after 3m1s
[20:17:42.844] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:77:0)
[20:17:42.861] Build status: STARTED
[20:17:42.861] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:78:0) after 2m35s
[20:20:17.936] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:78:0)
[20:20:17.955] Build status: STARTED
[20:20:17.955] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:79:0) after 1m46s
[20:22:03.977] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:79:0)
[20:22:03.997] Build status: STARTED
[20:22:03.997] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:80:0) after 7m10s
[20:29:14.124] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:80:0)
[20:29:14.207] Build status: STARTED
[20:29:14.208] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:81:0) after 6m22s
[20:35:36.365] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:81:0)
[20:35:36.386] Build status: STARTED
[20:35:36.386] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:82:0) after 8m47s
[20:44:23.518] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:82:0)
[20:44:23.559] Build status: STARTED
[20:44:23.559] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:83:0) after 5m26s
[20:49:49.717] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:83:0)
[20:49:49.764] Build status: STARTED
[20:49:49.764] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:84:0) after 9m59s
[20:59:48.783] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:84:0)
[20:59:48.801] Build status: STARTED
[20:59:48.801] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:85:0) after 2m37s
[21:02:25.820] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:85:0)
[21:02:25.843] Build status: STARTED
[21:02:25.843] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:86:0) after 6m22s
[21:08:47.943] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:86:0)
[21:08:47.964] Build status: STARTED
[21:08:47.964] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:87:0) after 3m51s
[21:12:38.983] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:87:0)
[21:12:39.004] Build status: STARTED
[21:12:39.004] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:88:0) after 4m5s
[21:16:44.025] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:88:0)
[21:16:44.052] Build status: STARTED
[21:16:44.052] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:89:0) after 1m8s
[21:17:52.083] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:89:0)
[21:17:52.100] Build status: STARTED
[21:17:52.100] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:90:0) after 3m58s
[21:21:50.349] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:90:0)
[21:21:50.373] Build status: STARTED
[21:21:50.373] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:91:0) after 6m27s
[21:28:17.460] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:91:0)
[21:28:17.487] Build status: STARTED
[21:28:17.487] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:92:0) after 5m15s
[21:33:32.529] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:92:0)
[21:33:32.548] Build status: STARTED
[21:33:32.548] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:93:0) after 8m2s
[21:41:34.599] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:93:0)
[21:41:34.616] Build status: STARTED
[21:41:34.616] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:94:0) after 7m35s
[21:49:09.689] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:94:0)
[21:49:09.705] Build status: STARTED
[21:49:09.705] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:95:0) after 1m17s
[21:50:26.725] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:95:0)
[21:50:26.753] Build status: STARTED
[21:50:26.753] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:96:0) after 6m27s
[21:56:53.791] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:96:0)
[21:56:53.811] Build status: STARTED
[21:56:53.811] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:97:0) after 9m8s
[22:06:01.978] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:97:0)
[22:06:02.005] Build status: STARTED
[22:06:02.005] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:98:0) after 7m37s
[22:13:39.190] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:98:0)
[22:13:39.259] Build status: STARTED
[22:13:39.259] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:99:0) after 1m39s
[22:15:18.277] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:99:0)
[22:15:18.299] Build status: STARTED
[22:15:18.299] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:100:0) after 2m25s
[22:17:43.369] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:100:0)
[22:17:43.387] Build status: STARTED
[22:17:43.387] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:101:0) after 7m1s
[22:24:44.759] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:101:0)
[22:24:44.775] Build status: STARTED
[22:24:44.775] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:102:0) after 6m22s
[22:31:06.899] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:102:0)
[22:31:06.920] Build status: STARTED
[22:31:06.920] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:103:0) after 3m31s
[22:34:37.940] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:103:0)
[22:34:37.956] Build status: STARTED
[22:34:37.956] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:104:0) after 4m45s
[22:39:22.973] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:104:0)
[22:39:22.995] Build status: STARTED
[22:39:22.995] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:105:0) after 8m9s
[22:47:32.274] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:105:0)
[22:47:32.298] Build status: STARTED
[22:47:32.298] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:106:0) after 8m21s
[22:55:53.362] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:106:0)
[22:55:53.399] Build status: STARTED
[22:55:53.399] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:107:0) after 8m3s
[23:03:56.428] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:107:0)
[23:03:56.448] Build status: STARTED
[23:03:56.448] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:108:0) after 3m42s
[23:07:38.509] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:108:0)
[23:07:38.530] Build status: STARTED
[23:07:38.530] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:109:0) after 4m27s
[23:12:05.556] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:109:0)
[23:12:05.575] Build status: STARTED
[23:12:05.575] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:110:0) after 7m14s
[23:19:19.586] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:110:0)
[23:19:19.606] Build status: STARTED
[23:19:19.606] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:111:0) after 7m50s
[23:27:09.627] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:111:0)
[23:27:09.665] Build status: STARTED
[23:27:09.665] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:112:0) after 4m31s
[23:31:40.686] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:112:0)
[23:31:40.704] Build status: STARTED
[23:31:40.704] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:113:0) after 4m26s
[23:36:07.369] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:113:0)
[23:36:07.387] Build status: STARTED
[23:36:07.387] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:114:0) after 9m39s
[23:45:46.561] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:114:0)
[23:45:46.594] Build status: STARTED
[23:45:46.594] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:115:0) after 3m33s
[23:49:20.065] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:115:0)
[23:49:20.085] Build status: STARTED
[23:49:20.085] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:116:0) after 4m37s
[23:53:57.266] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:116:0)
[23:53:57.287] Build status: STARTED
[23:53:57.287] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:117:0) after 7m17s
[00:01:14.347] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:117:0)
[00:01:14.442] Build status: STARTED
[00:01:14.442] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8944736747104865648:118:0) after 5m45s
[00:03:33.949] Received PubSub notification, asking Buildbucket for the build status
[00:03:33.986] Build:
{
"id": "8779306685102655505",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "CrWinAsan"
},
"number": 11475,
"createdBy": "project:chromium",
"createTime": "2023-06-03T13:08:40.771202500Z",
"startTime": "2023-06-03T13:08:59.338627Z",
"endTime": "2023-06-04T00:03:32.370972507Z",
"updateTime": "2023-06-04T00:03:32.370972507Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "49eb4e097c1d2a92b8cc4164f24c214e15c21ced",
"ref": "refs/heads/main"
}
}
}
[00:03:33.986] Invocation finished in 10h54m54.508776748s with status FAILED