[01:49:59.310] New invocation is queued and will start shortly
[01:50:00.444] Starting the invocation (attempt 1)
[01:50:00.481] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0c83855e76fdc0a1e883e5fb4db843dc67ee27d7"
[01:50:00.481] Popped gitiles commit info from properties and tags
[01:50:00.481] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:50:00.481] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:50:00.482] Buildbucket request:
{
"requestId": "8895404098662323840",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "CrWinAsan"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "0c83855e76fdc0a1e883e5fb4db843dc67ee27d7",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8895404098662323840"
},
{
"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:50:01.066] Scheduled build:
{
"id": "8729974036587816705",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "CrWinAsan"
},
"number": 17650,
"createdBy": "project:chromium",
"createTime": "2024-11-29T01:50:00.620560028Z",
"updateTime": "2024-11-29T01:50:00.620560028Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "0c83855e76fdc0a1e883e5fb4db843dc67ee27d7",
"ref": "refs/heads/main"
}
}
}
[01:50:01.066] Task URL: https://cr-buildbucket.appspot.com/build/8729974036587816705
[01:50:01.067] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:2:0) after 9m46s
[01:50:02.050] Received PubSub notification, asking Buildbucket for the build status
[01:50:02.112] Build status: SCHEDULED
[01:50:55.620] Received PubSub notification, asking Buildbucket for the build status
[01:50:55.676] Build status: STARTED
[01:59:47.185] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:2:0)
[01:59:47.200] Build status: STARTED
[01:59:47.200] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:5:0) after 3m25s
[02:03:12.221] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:5:0)
[02:03:12.236] Build status: STARTED
[02:03:12.236] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:6:0) after 4m52s
[02:08:04.304] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:6:0)
[02:08:04.324] Build status: STARTED
[02:08:04.324] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:7:0) after 4m6s
[02:12:10.343] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:7:0)
[02:12:10.359] Build status: STARTED
[02:12:10.359] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:8:0) after 7m54s
[02:20:04.412] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:8:0)
[02:20:04.616] Build status: STARTED
[02:20:04.616] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:9:0) after 5m3s
[02:25:07.596] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:9:0)
[02:25:07.613] Build status: STARTED
[02:25:07.613] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:10:0) after 5m20s
[02:30:27.632] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:10:0)
[02:30:27.654] Build status: STARTED
[02:30:27.654] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:11:0) after 3m27s
[02:33:54.969] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:11:0)
[02:33:54.991] Build status: STARTED
[02:33:54.991] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:12:0) after 7m24s
[02:41:19.174] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:12:0)
[02:41:19.222] Build status: STARTED
[02:41:19.222] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:13:0) after 9m37s
[02:50:56.734] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:13:0)
[02:50:56.757] Build status: STARTED
[02:50:56.757] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:14:0) after 8m34s
[02:59:30.776] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:14:0)
[02:59:30.879] Build status: STARTED
[02:59:30.880] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:15:0) after 6m2s
[03:05:33.179] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:15:0)
[03:05:33.194] Build status: STARTED
[03:05:33.194] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:16:0) after 5m35s
[03:11:08.232] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:16:0)
[03:11:08.254] Build status: STARTED
[03:11:08.254] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:17:0) after 2m45s
[03:13:53.433] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:17:0)
[03:13:53.512] Build status: STARTED
[03:13:53.512] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:18:0) after 7m29s
[03:21:22.536] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:18:0)
[03:21:22.559] Build status: STARTED
[03:21:22.559] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:19:0) after 3m57s
[03:25:19.582] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:19:0)
[03:25:19.601] Build status: STARTED
[03:25:19.601] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:20:0) after 1m14s
[03:26:33.622] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:20:0)
[03:26:33.642] Build status: STARTED
[03:26:33.642] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:21:0) after 9m17s
[03:35:50.693] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:21:0)
[03:35:50.719] Build status: STARTED
[03:35:50.719] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:22:0) after 2m47s
[03:38:37.833] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:22:0)
[03:38:37.855] Build status: STARTED
[03:38:37.855] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:23:0) after 2m37s
[03:41:14.874] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:23:0)
[03:41:14.892] Build status: STARTED
[03:41:14.892] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:24:0) after 5m51s
[03:47:05.920] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:24:0)
[03:47:05.938] Build status: STARTED
[03:47:05.938] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:25:0) after 5m10s
[03:52:16.062] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:25:0)
[03:52:16.096] Build status: STARTED
[03:52:16.096] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:26:0) after 7m56s
[04:00:12.269] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:26:0)
[04:00:12.288] Build status: STARTED
[04:00:12.288] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:27:0) after 7m39s
[04:07:51.311] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:27:0)
[04:07:51.372] Build status: STARTED
[04:07:51.372] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:28:0) after 1m10s
[04:09:01.486] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:28:0)
[04:09:01.534] Build status: STARTED
[04:09:01.534] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:29:0) after 7m50s
[04:16:51.556] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:29:0)
[04:16:51.628] Build status: STARTED
[04:16:51.628] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:30:0) after 8m36s
[04:25:27.650] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:30:0)
[04:25:27.667] Build status: STARTED
[04:25:27.667] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:31:0) after 1m38s
[04:27:05.773] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:31:0)
[04:27:05.819] Build status: STARTED
[04:27:05.819] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:32:0) after 6m37s
[04:33:42.941] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:32:0)
[04:33:42.964] Build status: STARTED
[04:33:42.964] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:33:0) after 7m0s
[04:40:43.090] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:33:0)
[04:40:43.117] Build status: STARTED
[04:40:43.117] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:34:0) after 1m34s
[04:42:17.135] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:34:0)
[04:42:17.152] Build status: STARTED
[04:42:17.152] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:35:0) after 6m47s
[04:49:04.336] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:35:0)
[04:49:04.400] Build status: STARTED
[04:49:04.400] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:36:0) after 2m27s
[04:51:31.443] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:36:0)
[04:51:31.539] Build status: STARTED
[04:51:31.539] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:37:0) after 9m5s
[05:00:36.559] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:37:0)
[05:00:36.583] Build status: STARTED
[05:00:36.583] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:38:0) after 8m8s
[05:08:44.614] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:38:0)
[05:08:44.634] Build status: STARTED
[05:08:44.634] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:39:0) after 2m8s
[05:10:52.813] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:39:0)
[05:10:52.878] Build status: STARTED
[05:10:52.878] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:40:0) after 1m2s
[05:11:54.999] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:40:0)
[05:11:55.023] Build status: STARTED
[05:11:55.023] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:41:0) after 5m22s
[05:17:17.137] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:41:0)
[05:17:17.155] Build status: STARTED
[05:17:17.155] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:42:0) after 8m43s
[05:26:00.271] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:42:0)
[05:26:00.347] Build status: STARTED
[05:26:00.347] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:43:0) after 2m58s
[05:28:58.322] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:43:0)
[05:28:58.400] Build status: STARTED
[05:28:58.400] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:44:0) after 8m9s
[05:37:07.462] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:44:0)
[05:37:07.480] Build status: STARTED
[05:37:07.481] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:45:0) after 8m27s
[05:45:34.600] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:45:0)
[05:45:34.619] Build status: STARTED
[05:45:34.619] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:46:0) after 6m3s
[05:51:37.741] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:46:0)
[05:51:37.759] Build status: STARTED
[05:51:37.759] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:47:0) after 1m11s
[05:52:48.783] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:47:0)
[05:52:48.833] Build status: STARTED
[05:52:48.833] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:48:0) after 5m34s
[05:58:22.835] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:48:0)
[05:58:22.904] Build status: STARTED
[05:58:22.904] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:49:0) after 3m18s
[06:01:40.936] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:49:0)
[06:01:41.029] Build status: STARTED
[06:01:41.030] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:50:0) after 1m8s
[06:02:49.070] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:50:0)
[06:02:49.086] Build status: STARTED
[06:02:49.086] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:51:0) after 3m18s
[06:06:07.389] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:51:0)
[06:06:07.457] Build status: STARTED
[06:06:07.457] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:52:0) after 4m37s
[06:10:44.479] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:52:0)
[06:10:44.510] Build status: STARTED
[06:10:44.510] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:53:0) after 1m58s
[06:12:42.579] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:53:0)
[06:12:42.600] Build status: STARTED
[06:12:42.600] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:54:0) after 9m2s
[06:21:44.653] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:54:0)
[06:21:44.706] Build status: STARTED
[06:21:44.706] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:55:0) after 3m42s
[06:25:26.775] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:55:0)
[06:25:26.791] Build status: STARTED
[06:25:26.791] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:56:0) after 6m21s
[06:31:47.811] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:56:0)
[06:31:47.828] Build status: STARTED
[06:31:47.828] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:57:0) after 3m21s
[06:35:09.048] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:57:0)
[06:35:09.068] Build status: STARTED
[06:35:09.068] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:58:0) after 1m33s
[06:36:42.093] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:58:0)
[06:36:42.115] Build status: STARTED
[06:36:42.116] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:59:0) after 2m46s
[06:39:28.211] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:59:0)
[06:39:28.232] Build status: STARTED
[06:39:28.232] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:60:0) after 9m7s
[06:48:35.268] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:60:0)
[06:48:35.291] Build status: STARTED
[06:48:35.291] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:61:0) after 5m50s
[06:54:25.452] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:61:0)
[06:54:25.468] Build status: STARTED
[06:54:25.468] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:62:0) after 8m38s
[07:03:03.628] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:62:0)
[07:03:03.641] Build status: STARTED
[07:03:03.641] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:63:0) after 1m22s
[07:04:25.800] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:63:0)
[07:04:25.818] Build status: STARTED
[07:04:25.818] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:64:0) after 7m44s
[07:12:09.840] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:64:0)
[07:12:09.857] Build status: STARTED
[07:12:09.857] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:65:0) after 8m16s
[07:20:25.877] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:65:0)
[07:20:25.895] Build status: STARTED
[07:20:25.895] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:66:0) after 6m56s
[07:27:22.139] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:66:0)
[07:27:22.204] Build status: STARTED
[07:27:22.204] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:67:0) after 5m22s
[07:32:44.276] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:67:0)
[07:32:44.300] Build status: STARTED
[07:32:44.300] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:68:0) after 9m23s
[07:42:07.318] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:68:0)
[07:42:07.335] Build status: STARTED
[07:42:07.335] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:69:0) after 5m16s
[07:47:23.355] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:69:0)
[07:47:23.377] Build status: STARTED
[07:47:23.377] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:70:0) after 2m57s
[07:50:20.407] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:70:0)
[07:50:20.429] Build status: STARTED
[07:50:20.429] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:71:0) after 8m42s
[07:59:02.551] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:71:0)
[07:59:02.576] Build status: STARTED
[07:59:02.576] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:72:0) after 4m23s
[08:03:25.558] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:72:0)
[08:03:25.579] Build status: STARTED
[08:03:25.592] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:73:0) after 4m52s
[08:08:17.717] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:73:0)
[08:08:17.733] Build status: STARTED
[08:08:17.733] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:74:0) after 2m39s
[08:10:56.755] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:74:0)
[08:10:56.769] Build status: STARTED
[08:10:56.769] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:75:0) after 9m24s
[08:20:20.761] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:75:0)
[08:20:20.850] Build status: STARTED
[08:20:20.850] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:76:0) after 9m52s
[08:30:12.934] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:76:0)
[08:30:12.957] Build status: STARTED
[08:30:12.957] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:77:0) after 5m44s
[08:35:56.968] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:77:0)
[08:35:56.988] Build status: STARTED
[08:35:56.988] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:78:0) after 5m14s
[08:41:11.018] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:78:0)
[08:41:11.034] Build status: STARTED
[08:41:11.034] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:79:0) after 8m36s
[08:49:47.275] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:79:0)
[08:49:47.298] Build status: STARTED
[08:49:47.298] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:80:0) after 4m5s
[08:53:52.476] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:80:0)
[08:53:52.529] Build status: STARTED
[08:53:52.529] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:81:0) after 4m48s
[08:58:40.914] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:81:0)
[08:58:40.932] Build status: STARTED
[08:58:40.932] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:82:0) after 6m19s
[09:05:00.022] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:82:0)
[09:05:00.037] Build status: STARTED
[09:05:00.037] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:83:0) after 1m32s
[09:06:32.308] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:83:0)
[09:06:32.335] Build status: STARTED
[09:06:32.335] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:84:0) after 6m58s
[09:13:30.364] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:84:0)
[09:13:30.381] Build status: STARTED
[09:13:30.381] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:85:0) after 5m2s
[09:18:32.591] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:85:0)
[09:18:32.606] Build status: STARTED
[09:18:32.606] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:86:0) after 1m48s
[09:20:20.656] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:86:0)
[09:20:20.679] Build status: STARTED
[09:20:20.679] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:87:0) after 1m6s
[09:21:26.703] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:87:0)
[09:21:26.719] Build status: STARTED
[09:21:26.719] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:88:0) after 5m11s
[09:26:37.740] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:88:0)
[09:26:37.760] Build status: STARTED
[09:26:37.760] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:89:0) after 5m35s
[09:32:12.880] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:89:0)
[09:32:12.906] Build status: STARTED
[09:32:12.906] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:90:0) after 8m52s
[09:41:05.022] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:90:0)
[09:41:05.035] Build status: STARTED
[09:41:05.035] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:91:0) after 5m5s
[09:46:10.177] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:91:0)
[09:46:10.199] Build status: STARTED
[09:46:10.199] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:92:0) after 5m53s
[09:52:03.172] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:92:0)
[09:52:03.187] Build status: STARTED
[09:52:03.187] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:93:0) after 9m0s
[10:01:03.448] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:93:0)
[10:01:03.470] Build status: STARTED
[10:01:03.470] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:94:0) after 6m21s
[10:07:24.664] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:94:0)
[10:07:24.681] Build status: STARTED
[10:07:24.681] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:95:0) after 2m13s
[10:09:37.706] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:95:0)
[10:09:37.725] Build status: STARTED
[10:09:37.725] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:96:0) after 7m46s
[10:17:23.747] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:96:0)
[10:17:23.889] Build status: STARTED
[10:17:23.889] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:97:0) after 4m23s
[10:21:47.093] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:97:0)
[10:21:47.113] Build status: STARTED
[10:21:47.113] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:98:0) after 7m47s
[10:29:34.138] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:98:0)
[10:29:34.165] Build status: STARTED
[10:29:34.165] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:99:0) after 4m10s
[10:33:44.190] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:99:0)
[10:33:44.217] Build status: STARTED
[10:33:44.217] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:100:0) after 6m44s
[10:40:28.295] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:100:0)
[10:40:28.314] Build status: STARTED
[10:40:28.314] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:101:0) after 9m25s
[10:49:53.409] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:101:0)
[10:49:53.427] Build status: STARTED
[10:49:53.427] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:102:0) after 6m50s
[10:56:43.508] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:102:0)
[10:56:43.524] Build status: STARTED
[10:56:43.524] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:103:0) after 6m24s
[11:03:07.632] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:103:0)
[11:03:07.651] Build status: STARTED
[11:03:07.651] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:104:0) after 5m23s
[11:08:30.716] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:104:0)
[11:08:30.771] Build status: STARTED
[11:08:30.771] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:105:0) after 2m14s
[11:10:44.891] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:105:0)
[11:10:44.916] Build status: STARTED
[11:10:44.916] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:106:0) after 4m7s
[11:14:52.012] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:106:0)
[11:14:52.025] Build status: STARTED
[11:14:52.025] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:107:0) after 4m54s
[11:19:46.046] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:107:0)
[11:19:46.082] Build status: STARTED
[11:19:46.082] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:108:0) after 5m30s
[11:25:16.281] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:108:0)
[11:25:16.294] Build status: STARTED
[11:25:16.294] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:109:0) after 3m35s
[11:28:51.451] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:109:0)
[11:28:51.470] Build status: STARTED
[11:28:51.470] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:110:0) after 6m21s
[11:35:12.539] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:110:0)
[11:35:12.582] Build status: STARTED
[11:35:12.582] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:111:0) after 2m41s
[11:37:53.611] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:111:0)
[11:37:53.634] Build status: STARTED
[11:37:53.634] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:8895404098662323840:112:0) after 8m12s
[11:40:27.175] Received PubSub notification, asking Buildbucket for the build status
[11:40:27.197] Build:
{
"id": "8729974036587816705",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "CrWinAsan"
},
"number": 17650,
"createdBy": "project:chromium",
"createTime": "2024-11-29T01:50:00.620560028Z",
"startTime": "2024-11-29T01:50:55.389848240Z",
"endTime": "2024-11-29T11:40:26.770738208Z",
"updateTime": "2024-11-29T11:40:26.770738208Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "0c83855e76fdc0a1e883e5fb4db843dc67ee27d7",
"ref": "refs/heads/main"
}
}
}
[11:40:27.197] Invocation finished in 9h50m27.938302863s with status SUCCEEDED