[18:27:21.037] New invocation is queued and will start shortly
[18:27:22.151] Starting the invocation (attempt 1)
[18:27:22.189] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dd9fe191f926c450a1b72a1790492e7ada0b7cd2"
[18:27:22.189] Popped gitiles commit info from properties and tags
[18:27:22.189] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:27:22.189] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:27:22.190] Buildbucket request:
{
"requestId": "8884650907979113728",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "CrWinAsan"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "dd9fe191f926c450a1b72a1790492e7ada0b7cd2",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8884650907979113728"
},
{
"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"
}
}
[18:27:22.757] Scheduled build:
{
"id": "8719220846060847729",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "CrWinAsan"
},
"number": 18475,
"createdBy": "project:chromium",
"createTime": "2025-03-27T18:27:22.245935022Z",
"updateTime": "2025-03-27T18:27:22.245935022Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "dd9fe191f926c450a1b72a1790492e7ada0b7cd2",
"ref": "refs/heads/main"
}
}
}
[18:27:22.757] Task URL: https://cr-buildbucket.appspot.com/build/8719220846060847729
[18:27:22.757] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:2:0) after 7m38s
[18:27:23.718] Received PubSub notification, asking Buildbucket for the build status
[18:27:23.740] Build status: SCHEDULED
[18:35:00.864] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:2:0)
[18:35:00.910] Build status: SCHEDULED
[18:35:00.910] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:4:0) after 3m50s
[18:38:50.982] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:4:0)
[18:38:51.008] Build status: SCHEDULED
[18:38:51.008] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:5:0) after 2m42s
[18:41:33.049] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:5:0)
[18:41:33.078] Build status: SCHEDULED
[18:41:33.078] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:6:0) after 5m19s
[18:46:52.114] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:6:0)
[18:46:52.140] Build status: SCHEDULED
[18:46:52.140] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:7:0) after 7m2s
[18:53:54.172] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:7:0)
[18:53:54.204] Build status: SCHEDULED
[18:53:54.204] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:8:0) after 3m18s
[18:57:12.377] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:8:0)
[18:57:12.396] Build status: SCHEDULED
[18:57:12.396] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:9:0) after 3m17s
[19:00:29.458] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:9:0)
[19:00:29.517] Build status: SCHEDULED
[19:00:29.517] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:10:0) after 3m18s
[19:03:47.529] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:10:0)
[19:03:47.544] Build status: SCHEDULED
[19:03:47.544] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:11:0) after 6m53s
[19:10:40.623] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:11:0)
[19:10:40.652] Build status: SCHEDULED
[19:10:40.652] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:12:0) after 3m4s
[19:11:38.667] Received PubSub notification, asking Buildbucket for the build status
[19:11:38.740] Build status: STARTED
[19:13:44.709] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:12:0)
[19:13:44.740] Build status: STARTED
[19:13:44.740] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:14:0) after 1m21s
[19:15:05.775] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:14:0)
[19:15:05.800] Build status: STARTED
[19:15:05.800] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:15:0) after 4m52s
[19:19:57.878] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:15:0)
[19:19:57.905] Build status: STARTED
[19:19:57.905] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:16:0) after 6m55s
[19:26:52.936] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:16:0)
[19:26:52.963] Build status: STARTED
[19:26:52.963] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:17:0) after 9m10s
[19:36:03.079] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:17:0)
[19:36:03.103] Build status: STARTED
[19:36:03.103] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:18:0) after 6m25s
[19:42:28.131] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:18:0)
[19:42:28.149] Build status: STARTED
[19:42:28.149] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:19:0) after 6m33s
[19:49:01.299] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:19:0)
[19:49:01.329] Build status: STARTED
[19:49:01.329] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:20:0) after 4m36s
[19:53:37.430] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:20:0)
[19:53:37.455] Build status: STARTED
[19:53:37.455] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:21:0) after 7m59s
[20:01:36.565] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:21:0)
[20:01:36.578] Build status: STARTED
[20:01:36.578] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:22:0) after 1m23s
[20:02:59.664] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:22:0)
[20:02:59.685] Build status: STARTED
[20:02:59.685] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:23:0) after 1m19s
[20:04:18.727] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:23:0)
[20:04:18.752] Build status: STARTED
[20:04:18.752] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:24:0) after 4m7s
[20:08:25.786] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:24:0)
[20:08:25.801] Build status: STARTED
[20:08:25.801] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:25:0) after 4m16s
[20:12:41.884] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:25:0)
[20:12:41.950] Build status: STARTED
[20:12:41.950] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:26:0) after 9m52s
[20:22:33.988] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:26:0)
[20:22:34.004] Build status: STARTED
[20:22:34.004] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:27:0) after 4m58s
[20:27:32.030] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:27:0)
[20:27:32.046] Build status: STARTED
[20:27:32.046] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:28:0) after 6m19s
[20:33:51.127] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:28:0)
[20:33:51.146] Build status: STARTED
[20:33:51.146] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:29:0) after 1m15s
[20:35:06.226] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:29:0)
[20:35:06.282] Build status: STARTED
[20:35:06.283] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:30:0) after 8m34s
[20:43:40.330] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:30:0)
[20:43:40.348] Build status: STARTED
[20:43:40.348] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:31:0) after 3m39s
[20:47:19.419] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:31:0)
[20:47:19.434] Build status: STARTED
[20:47:19.434] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:32:0) after 1m49s
[20:49:08.539] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:32:0)
[20:49:08.582] Build status: STARTED
[20:49:08.582] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:33:0) after 3m3s
[20:52:11.613] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:33:0)
[20:52:11.631] Build status: STARTED
[20:52:11.631] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:34:0) after 5m56s
[20:58:07.698] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:34:0)
[20:58:07.714] Build status: STARTED
[20:58:07.714] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:35:0) after 7m18s
[21:05:25.747] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:35:0)
[21:05:25.764] Build status: STARTED
[21:05:25.764] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:36:0) after 2m58s
[21:08:23.841] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:36:0)
[21:08:23.860] Build status: STARTED
[21:08:23.860] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:37:0) after 2m28s
[21:10:51.912] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:37:0)
[21:10:51.931] Build status: STARTED
[21:10:51.931] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:38:0) after 8m46s
[21:19:38.003] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:38:0)
[21:19:38.027] Build status: STARTED
[21:19:38.027] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:39:0) after 5m41s
[21:25:19.105] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:39:0)
[21:25:19.124] Build status: STARTED
[21:25:19.124] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:40:0) after 9m16s
[21:34:35.205] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:40:0)
[21:34:35.222] Build status: STARTED
[21:34:35.222] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:41:0) after 1m35s
[21:36:10.285] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:41:0)
[21:36:10.311] Build status: STARTED
[21:36:10.311] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:42:0) after 8m16s
[21:44:26.345] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:42:0)
[21:44:26.362] Build status: STARTED
[21:44:26.362] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:43:0) after 4m40s
[21:49:06.431] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:43:0)
[21:49:06.447] Build status: STARTED
[21:49:06.447] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:44:0) after 3m32s
[21:52:38.474] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:44:0)
[21:52:38.543] Build status: STARTED
[21:52:38.543] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:45:0) after 6m44s
[21:59:22.526] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:45:0)
[21:59:22.541] Build status: STARTED
[21:59:22.541] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:46:0) after 2m32s
[22:01:54.569] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:46:0)
[22:01:54.591] Build status: STARTED
[22:01:54.591] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:47:0) after 7m6s
[22:09:00.592] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:47:0)
[22:09:00.612] Build status: STARTED
[22:09:00.612] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:48:0) after 2m34s
[22:11:34.635] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:48:0)
[22:11:34.651] Build status: STARTED
[22:11:34.651] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:49:0) after 5m49s
[22:17:23.682] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:49:0)
[22:17:23.698] Build status: STARTED
[22:17:23.698] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:50:0) after 9m33s
[22:26:56.776] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:50:0)
[22:26:56.792] Build status: STARTED
[22:26:56.792] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:51:0) after 8m51s
[22:35:47.816] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:51:0)
[22:35:47.833] Build status: STARTED
[22:35:47.833] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:52:0) after 2m28s
[22:38:15.962] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:52:0)
[22:38:15.987] Build status: STARTED
[22:38:15.987] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:53:0) after 2m55s
[22:41:11.059] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:53:0)
[22:41:11.077] Build status: STARTED
[22:41:11.077] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:54:0) after 3m37s
[22:44:48.077] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:54:0)
[22:44:48.096] Build status: STARTED
[22:44:48.096] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:55:0) after 9m47s
[22:54:35.164] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:55:0)
[22:54:35.179] Build status: STARTED
[22:54:35.179] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:56:0) after 7m7s
[23:01:42.195] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:56:0)
[23:01:42.212] Build status: STARTED
[23:01:42.212] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:57:0) after 7m31s
[23:09:13.337] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:57:0)
[23:09:13.360] Build status: STARTED
[23:09:13.360] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:58:0) after 9m14s
[23:18:27.398] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:58:0)
[23:18:27.415] Build status: STARTED
[23:18:27.415] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:59:0) after 3m0s
[23:21:27.496] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:59:0)
[23:21:27.516] Build status: STARTED
[23:21:27.516] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:60:0) after 9m25s
[23:30:52.547] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:60:0)
[23:30:52.564] Build status: STARTED
[23:30:52.564] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:61:0) after 7m56s
[23:38:48.602] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:61:0)
[23:38:48.624] Build status: STARTED
[23:38:48.624] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:62:0) after 5m28s
[23:44:16.817] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:62:0)
[23:44:16.836] Build status: STARTED
[23:44:16.836] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:63:0) after 6m8s
[23:50:24.874] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:63:0)
[23:50:24.941] Build status: STARTED
[23:50:24.941] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:64:0) after 8m6s
[23:58:30.966] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:64:0)
[23:58:30.984] Build status: STARTED
[23:58:30.984] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:65:0) after 2m20s
[00:00:51.104] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:65:0)
[00:00:51.129] Build status: STARTED
[00:00:51.129] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:66:0) after 3m24s
[00:04:15.162] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:66:0)
[00:04:15.264] Build status: STARTED
[00:04:15.264] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:67:0) after 7m30s
[00:11:45.321] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:67:0)
[00:11:45.339] Build status: STARTED
[00:11:45.339] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:68:0) after 6m3s
[00:17:48.373] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:68:0)
[00:17:48.391] Build status: STARTED
[00:17:48.391] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:69:0) after 8m12s
[00:26:00.381] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:69:0)
[00:26:00.457] Build status: STARTED
[00:26:00.457] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:70:0) after 7m39s
[00:33:39.485] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:70:0)
[00:33:39.504] Build status: STARTED
[00:33:39.504] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:71:0) after 5m54s
[00:39:33.571] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:71:0)
[00:39:33.587] Build status: STARTED
[00:39:33.587] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:72:0) after 6m35s
[00:46:08.608] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:72:0)
[00:46:08.639] Build status: STARTED
[00:46:08.639] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:73:0) after 3m27s
[00:49:35.666] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:73:0)
[00:49:35.686] Build status: STARTED
[00:49:35.686] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:74:0) after 3m49s
[00:53:24.763] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:74:0)
[00:53:24.837] Build status: STARTED
[00:53:24.837] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:75:0) after 9m4s
[01:02:28.865] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:75:0)
[01:02:28.881] Build status: STARTED
[01:02:28.881] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:76:0) after 7m5s
[01:09:33.961] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:76:0)
[01:09:33.976] Build status: STARTED
[01:09:33.976] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:77:0) after 6m44s
[01:16:18.010] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:77:0)
[01:16:18.026] Build status: STARTED
[01:16:18.026] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:78:0) after 5m51s
[01:22:09.056] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:78:0)
[01:22:09.074] Build status: STARTED
[01:22:09.074] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:79:0) after 6m39s
[01:28:48.149] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:79:0)
[01:28:48.166] Build status: STARTED
[01:28:48.166] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:80:0) after 7m15s
[01:36:03.245] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:80:0)
[01:36:03.428] Build status: STARTED
[01:36:03.428] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:81:0) after 6m44s
[01:42:47.457] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:81:0)
[01:42:47.477] Build status: STARTED
[01:42:47.477] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:82:0) after 1m3s
[01:43:50.510] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:82:0)
[01:43:50.536] Build status: STARTED
[01:43:50.536] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:83:0) after 5m53s
[01:49:43.600] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:83:0)
[01:49:43.618] Build status: STARTED
[01:49:43.618] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:84:0) after 9m29s
[01:59:12.641] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:84:0)
[01:59:12.668] Build status: STARTED
[01:59:12.668] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:85:0) after 4m5s
[02:03:17.716] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:85:0)
[02:03:17.753] Build status: STARTED
[02:03:17.753] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:86:0) after 5m57s
[02:09:14.788] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:86:0)
[02:09:14.808] Build status: STARTED
[02:09:14.808] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:87:0) after 7m54s
[02:17:08.850] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:87:0)
[02:17:08.867] Build status: STARTED
[02:17:08.867] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:88:0) after 5m26s
[02:22:34.999] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:88:0)
[02:22:35.014] Build status: STARTED
[02:22:35.015] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:89:0) after 8m57s
[02:31:32.099] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:89:0)
[02:31:32.125] Build status: STARTED
[02:31:32.125] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8884650907979113728:90:0) after 9m45s
[02:36:50.605] Received PubSub notification, asking Buildbucket for the build status
[02:36:50.624] Build:
{
"id": "8719220846060847729",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "CrWinAsan"
},
"number": 18475,
"createdBy": "project:chromium",
"createTime": "2025-03-27T18:27:22.245935022Z",
"startTime": "2025-03-27T19:11:38.266881021Z",
"endTime": "2025-03-28T02:36:31.191209233Z",
"updateTime": "2025-03-28T02:36:31.191209233Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "dd9fe191f926c450a1b72a1790492e7ada0b7cd2",
"ref": "refs/heads/main"
}
}
}
[02:36:50.624] Invocation finished in 8h9m29.592489062s with status FAILED