[19:32:06.211] New invocation is queued and will start shortly
[19:32:07.310] Starting the invocation (attempt 1)
[19:32:07.358] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/008770b0320ad8765629609380e78b5b66f3bcef"
[19:32:07.359] Popped gitiles commit info from properties and tags
[19:32:07.359] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:32:07.359] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:32:07.359] Buildbucket request:
{
"requestId": "8965096940258757136",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "CFI Linux ToT"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "008770b0320ad8765629609380e78b5b66f3bcef",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8965096940258757136"
},
{
"key": "scheduler_job_id",
"value": "chromium/CFI Linux ToT"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[19:32:07.916] Scheduled build:
{
"id": "8799666878273812385",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "CFI Linux ToT"
},
"number": 17267,
"createdBy": "project:chromium",
"createTime": "2022-10-21T19:32:07.467541489Z",
"updateTime": "2022-10-21T19:32:07.467541489Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "008770b0320ad8765629609380e78b5b66f3bcef",
"ref": "refs/heads/main"
}
},
"canary": true
}
[19:32:07.916] Task URL: https://cr-buildbucket.appspot.com/build/8799666878273812385
[19:32:07.916] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:2:0) after 8m12s
[19:35:11.538] Received PubSub notification, asking Buildbucket for the build status
[19:35:11.570] Build status: STARTED
[19:40:20.085] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:2:0)
[19:40:20.117] Build status: STARTED
[19:40:20.118] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:4:0) after 8m26s
[19:48:46.139] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:4:0)
[19:48:46.227] Build status: STARTED
[19:48:46.227] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:5:0) after 7m16s
[19:56:02.325] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:5:0)
[19:56:02.349] Build status: STARTED
[19:56:02.349] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:6:0) after 2m44s
[19:58:46.485] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:6:0)
[19:58:46.519] Build status: STARTED
[19:58:46.519] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:7:0) after 7m50s
[20:06:36.597] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:7:0)
[20:06:36.622] Build status: STARTED
[20:06:36.622] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:8:0) after 2m27s
[20:09:03.662] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:8:0)
[20:09:03.774] Build status: STARTED
[20:09:03.774] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:9:0) after 6m58s
[20:16:01.848] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:9:0)
[20:16:01.878] Build status: STARTED
[20:16:01.878] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:10:0) after 6m22s
[20:22:23.919] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:10:0)
[20:22:23.942] Build status: STARTED
[20:22:23.942] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:11:0) after 3m27s
[20:25:51.587] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:11:0)
[20:25:51.611] Build status: STARTED
[20:25:51.611] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:12:0) after 9m49s
[20:35:40.663] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:12:0)
[20:35:40.685] Build status: STARTED
[20:35:40.685] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:13:0) after 5m57s
[20:41:37.715] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:13:0)
[20:41:37.737] Build status: STARTED
[20:41:37.738] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:14:0) after 8m30s
[20:50:23.639] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:14:0)
[20:50:23.663] Build status: STARTED
[20:50:23.663] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:15:0) after 4m41s
[20:55:05.098] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:15:0)
[20:55:05.118] Build status: STARTED
[20:55:05.118] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:16:0) after 5m28s
[21:00:33.161] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:16:0)
[21:00:33.182] Build status: STARTED
[21:00:33.182] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:17:0) after 5m34s
[21:06:07.221] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:17:0)
[21:06:07.269] Build status: STARTED
[21:06:07.269] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:18:0) after 8m33s
[21:14:40.422] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:18:0)
[21:14:40.499] Build status: STARTED
[21:14:40.499] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:19:0) after 5m28s
[21:20:08.999] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:19:0)
[21:20:09.027] Build status: STARTED
[21:20:09.027] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:20:0) after 9m28s
[21:29:37.075] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:20:0)
[21:29:37.099] Build status: STARTED
[21:29:37.099] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:21:0) after 2m20s
[21:31:57.172] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:21:0)
[21:31:57.196] Build status: STARTED
[21:31:57.196] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:22:0) after 4m36s
[21:36:33.393] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:22:0)
[21:36:33.415] Build status: STARTED
[21:36:33.416] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:23:0) after 8m36s
[21:45:09.456] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:23:0)
[21:45:09.491] Build status: STARTED
[21:45:09.491] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:24:0) after 7m6s
[21:52:15.578] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:24:0)
[21:52:15.602] Build status: STARTED
[21:52:15.602] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:25:0) after 4m16s
[21:56:31.667] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:25:0)
[21:56:31.690] Build status: STARTED
[21:56:31.690] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:26:0) after 7m16s
[22:03:47.768] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:26:0)
[22:03:47.793] Build status: STARTED
[22:03:47.793] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:27:0) after 9m15s
[22:13:02.837] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:27:0)
[22:13:02.862] Build status: STARTED
[22:13:02.862] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:28:0) after 5m0s
[22:18:03.087] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:28:0)
[22:18:03.111] Build status: STARTED
[22:18:03.111] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:29:0) after 9m22s
[22:27:25.141] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:29:0)
[22:27:25.166] Build status: STARTED
[22:27:25.166] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:30:0) after 4m33s
[22:31:58.209] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:30:0)
[22:31:58.234] Build status: STARTED
[22:31:58.234] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:31:0) after 2m47s
[22:34:45.237] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:31:0)
[22:34:45.263] Build status: STARTED
[22:34:45.263] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:32:0) after 8m4s
[22:42:49.323] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:32:0)
[22:42:49.349] Build status: STARTED
[22:42:49.349] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:33:0) after 7m15s
[22:50:04.600] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:33:0)
[22:50:04.627] Build status: STARTED
[22:50:04.627] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:34:0) after 9m3s
[22:59:08.034] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:34:0)
[22:59:08.055] Build status: STARTED
[22:59:08.055] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:35:0) after 6m22s
[23:05:30.087] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:35:0)
[23:05:30.110] Build status: STARTED
[23:05:30.110] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:36:0) after 3m16s
[23:08:46.372] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:36:0)
[23:08:46.397] Build status: STARTED
[23:08:46.397] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:37:0) after 9m32s
[23:18:18.664] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:37:0)
[23:18:18.693] Build status: STARTED
[23:18:18.693] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:38:0) after 8m15s
[23:26:33.727] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:38:0)
[23:26:33.748] Build status: STARTED
[23:26:33.748] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:39:0) after 8m57s
[23:35:30.877] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:39:0)
[23:35:30.907] Build status: STARTED
[23:35:30.907] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:40:0) after 7m9s
[23:42:39.936] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:40:0)
[23:42:39.960] Build status: STARTED
[23:42:39.960] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:41:0) after 7m24s
[23:50:03.986] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:41:0)
[23:50:04.039] Build status: STARTED
[23:50:04.039] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:42:0) after 1m29s
[23:51:33.261] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:42:0)
[23:51:33.283] Build status: STARTED
[23:51:33.283] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:43:0) after 3m47s
[23:55:20.767] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:43:0)
[23:55:20.788] Build status: STARTED
[23:55:20.788] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:44:0) after 7m41s
[00:03:02.044] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:44:0)
[00:03:02.184] Build status: STARTED
[00:03:02.184] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:45:0) after 3m47s
[00:06:49.259] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:45:0)
[00:06:49.286] Build status: STARTED
[00:06:49.286] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:46:0) after 2m12s
[00:09:01.408] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:46:0)
[00:09:01.434] Build status: STARTED
[00:09:01.434] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:47:0) after 7m36s
[00:16:37.664] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:47:0)
[00:16:37.695] Build status: STARTED
[00:16:37.695] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:48:0) after 9m53s
[00:26:30.796] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:48:0)
[00:26:30.823] Build status: STARTED
[00:26:30.823] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:49:0) after 4m6s
[00:30:36.868] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:49:0)
[00:30:36.898] Build status: STARTED
[00:30:36.898] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:50:0) after 9m19s
[00:39:56.389] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:50:0)
[00:39:56.411] Build status: STARTED
[00:39:56.411] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:51:0) after 2m2s
[00:41:58.445] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:51:0)
[00:41:58.473] Build status: STARTED
[00:41:58.473] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:52:0) after 4m35s
[00:46:33.740] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:52:0)
[00:46:33.767] Build status: STARTED
[00:46:33.767] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:53:0) after 6m24s
[00:52:57.884] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:53:0)
[00:52:57.922] Build status: STARTED
[00:52:57.922] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:54:0) after 9m49s
[01:02:47.071] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:54:0)
[01:02:47.101] Build status: STARTED
[01:02:47.101] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:55:0) after 9m56s
[01:12:43.163] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:55:0)
[01:12:43.186] Build status: STARTED
[01:12:43.186] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:56:0) after 3m27s
[01:16:10.590] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:56:0)
[01:16:10.620] Build status: STARTED
[01:16:10.620] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:57:0) after 7m3s
[01:23:13.681] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:57:0)
[01:23:13.703] Build status: STARTED
[01:23:13.703] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:58:0) after 2m31s
[01:25:45.091] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:58:0)
[01:25:45.117] Build status: STARTED
[01:25:45.117] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:59:0) after 5m8s
[01:30:53.271] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:59:0)
[01:30:53.294] Build status: STARTED
[01:30:53.295] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:60:0) after 4m56s
[01:35:49.813] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:60:0)
[01:35:49.835] Build status: STARTED
[01:35:49.835] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:61:0) after 7m5s
[01:42:54.916] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:61:0)
[01:42:54.940] Build status: STARTED
[01:42:54.940] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:62:0) after 3m57s
[01:46:52.572] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:62:0)
[01:46:52.596] Build status: STARTED
[01:46:52.596] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:63:0) after 3m11s
[01:50:04.054] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:63:0)
[01:50:04.498] Build status: STARTED
[01:50:04.498] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:64:0) after 1m39s
[01:51:43.537] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:64:0)
[01:51:43.699] Build status: STARTED
[01:51:43.700] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:65:0) after 5m44s
[01:57:27.898] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:65:0)
[01:57:27.942] Build status: STARTED
[01:57:27.942] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:66:0) after 8m21s
[02:05:48.996] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:66:0)
[02:05:49.021] Build status: STARTED
[02:05:49.021] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:67:0) after 3m18s
[02:09:07.147] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:67:0)
[02:09:07.168] Build status: STARTED
[02:09:07.168] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:68:0) after 2m5s
[02:11:12.249] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:68:0)
[02:11:12.270] Build status: STARTED
[02:11:12.270] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:69:0) after 6m22s
[02:17:34.428] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:69:0)
[02:17:34.451] Build status: STARTED
[02:17:34.451] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:70:0) after 5m45s
[02:23:19.483] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:70:0)
[02:23:19.505] Build status: STARTED
[02:23:19.505] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:71:0) after 6m56s
[02:30:15.541] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:71:0)
[02:30:15.572] Build status: STARTED
[02:30:15.572] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:72:0) after 5m22s
[02:35:37.609] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:72:0)
[02:35:37.634] Build status: STARTED
[02:35:37.634] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:73:0) after 5m39s
[02:41:16.752] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:73:0)
[02:41:16.774] Build status: STARTED
[02:41:16.774] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:74:0) after 8m50s
[02:50:06.807] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:74:0)
[02:50:06.833] Build status: STARTED
[02:50:06.833] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:75:0) after 2m8s
[02:52:14.975] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:75:0)
[02:52:14.999] Build status: STARTED
[02:52:14.999] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:76:0) after 7m59s
[03:00:14.414] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:76:0)
[03:00:14.476] Build status: STARTED
[03:00:14.476] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:77:0) after 5m19s
[03:05:33.518] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:77:0)
[03:05:33.548] Build status: STARTED
[03:05:33.548] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:78:0) after 5m27s
[03:11:00.583] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:78:0)
[03:11:00.605] Build status: STARTED
[03:11:00.605] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:79:0) after 6m22s
[03:17:22.682] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:79:0)
[03:17:22.709] Build status: STARTED
[03:17:22.709] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:80:0) after 9m26s
[03:26:48.754] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:80:0)
[03:26:48.779] Build status: STARTED
[03:26:48.779] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:81:0) after 8m22s
[03:35:10.819] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:81:0)
[03:35:10.854] Build status: STARTED
[03:35:10.854] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:82:0) after 1m11s
[03:36:21.863] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:82:0)
[03:36:21.897] Build status: STARTED
[03:36:21.897] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:83:0) after 1m46s
[03:38:07.897] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:83:0)
[03:38:07.927] Build status: STARTED
[03:38:07.927] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:84:0) after 5m21s
[03:43:28.957] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:84:0)
[03:43:28.988] Build status: STARTED
[03:43:28.988] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:85:0) after 7m35s
[03:51:04.243] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:85:0)
[03:51:04.268] Build status: STARTED
[03:51:04.268] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:86:0) after 5m28s
[03:56:32.440] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:86:0)
[03:56:32.462] Build status: STARTED
[03:56:32.462] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:87:0) after 2m56s
[03:59:28.445] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:87:0)
[03:59:28.468] Build status: STARTED
[03:59:28.468] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:88:0) after 5m21s
[04:04:49.500] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:88:0)
[04:04:49.521] Build status: STARTED
[04:04:49.521] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:89:0) after 3m55s
[04:08:44.852] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:89:0)
[04:08:44.903] Build status: STARTED
[04:08:44.903] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:90:0) after 7m27s
[04:16:11.955] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:90:0)
[04:16:11.980] Build status: STARTED
[04:16:11.981] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:91:0) after 4m23s
[04:20:35.177] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:91:0)
[04:20:35.210] Build status: STARTED
[04:20:35.210] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:92:0) after 2m44s
[04:23:19.290] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:92:0)
[04:23:19.335] Build status: STARTED
[04:23:19.335] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:93:0) after 3m35s
[04:26:54.354] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:93:0)
[04:26:54.381] Build status: STARTED
[04:26:54.381] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:94:0) after 5m49s
[04:32:43.425] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:94:0)
[04:32:43.452] Build status: STARTED
[04:32:43.452] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:95:0) after 2m23s
[04:35:06.518] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:95:0)
[04:35:06.543] Build status: STARTED
[04:35:06.543] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:96:0) after 9m53s
[04:44:59.577] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:96:0)
[04:44:59.600] Build status: STARTED
[04:44:59.600] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:97:0) after 1m42s
[04:46:41.631] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:97:0)
[04:46:41.656] Build status: STARTED
[04:46:41.657] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:98:0) after 1m3s
[04:47:44.724] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:98:0)
[04:47:44.747] Build status: STARTED
[04:47:44.747] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:99:0) after 3m6s
[04:50:50.892] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:99:0)
[04:50:50.951] Build status: STARTED
[04:50:50.951] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:100:0) after 6m10s
[04:57:01.101] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:100:0)
[04:57:01.126] Build status: STARTED
[04:57:01.126] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:101:0) after 4m11s
[05:01:12.129] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:101:0)
[05:01:12.153] Build status: STARTED
[05:01:12.153] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:102:0) after 6m28s
[05:07:40.283] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:102:0)
[05:07:40.305] Build status: STARTED
[05:07:40.305] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:103:0) after 9m29s
[05:17:09.599] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:103:0)
[05:17:09.628] Build status: STARTED
[05:17:09.628] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:104:0) after 7m20s
[05:24:29.664] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:104:0)
[05:24:29.692] Build status: STARTED
[05:24:29.692] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:105:0) after 1m22s
[05:25:51.732] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:105:0)
[05:25:51.755] Build status: STARTED
[05:25:51.756] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:106:0) after 5m47s
[05:31:38.819] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:106:0)
[05:31:38.854] Build status: STARTED
[05:31:38.854] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:107:0) after 7m21s
[05:38:59.933] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:107:0)
[05:38:59.957] Build status: STARTED
[05:38:59.957] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:108:0) after 3m0s
[05:41:59.999] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:108:0)
[05:42:00.035] Build status: STARTED
[05:42:00.035] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:109:0) after 5m51s
[05:47:51.178] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:109:0)
[05:47:51.208] Build status: STARTED
[05:47:51.208] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:110:0) after 6m54s
[05:54:45.246] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:110:0)
[05:54:45.266] Build status: STARTED
[05:54:45.266] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:111:0) after 2m44s
[05:57:29.373] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:111:0)
[05:57:29.399] Build status: STARTED
[05:57:29.399] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:112:0) after 7m51s
[06:05:20.448] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:112:0)
[06:05:20.469] Build status: STARTED
[06:05:20.469] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:113:0) after 7m0s
[06:12:20.503] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:113:0)
[06:12:20.533] Build status: STARTED
[06:12:20.533] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:114:0) after 4m21s
[06:16:41.564] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:114:0)
[06:16:41.585] Build status: STARTED
[06:16:41.585] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8965096940258757136:115:0) after 9m48s
[06:17:07.210] Received PubSub notification, asking Buildbucket for the build status
[06:17:07.271] Build:
{
"id": "8799666878273812385",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "CFI Linux ToT"
},
"number": 17267,
"createdBy": "project:chromium",
"createTime": "2022-10-21T19:32:07.467541489Z",
"startTime": "2022-10-21T19:35:10.712026Z",
"endTime": "2022-10-22T06:17:06.842581867Z",
"updateTime": "2022-10-22T06:17:06.842581867Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "008770b0320ad8765629609380e78b5b66f3bcef",
"ref": "refs/heads/main"
}
},
"canary": true
}
[06:17:07.271] Invocation finished in 10h45m1.081317468s with status FAILED