[07:17:50.402] New invocation is queued and will start shortly
[07:17:51.660] Starting the invocation (attempt 1)
[07:17:51.699] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/db38b1c1c0c12bee94f2b58ca5d8f74245059fec"
[07:17:51.699] Popped gitiles commit info from properties and tags
[07:17:51.699] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:17:51.699] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:17:51.700] Buildbucket request:
{
"requestId": "8956898812179181904",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "CFI Linux ToT"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "db38b1c1c0c12bee94f2b58ca5d8f74245059fec",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8956898812179181904"
},
{
"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"
}
}
[07:17:52.361] Scheduled build:
{
"id": "8791468750050148545",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "CFI Linux ToT"
},
"number": 17880,
"createdBy": "project:chromium",
"createTime": "2023-01-20T07:17:51.797892554Z",
"updateTime": "2023-01-20T07:17:51.797892554Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "db38b1c1c0c12bee94f2b58ca5d8f74245059fec",
"ref": "refs/heads/main"
}
}
}
[07:17:52.361] Task URL: https://cr-buildbucket.appspot.com/build/8791468750050148545
[07:17:52.361] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:2:0) after 7m30s
[07:19:23.296] Received PubSub notification, asking Buildbucket for the build status
[07:19:23.319] Build status: STARTED
[07:25:22.344] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:2:0)
[07:25:22.397] Build status: STARTED
[07:25:22.398] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:4:0) after 9m19s
[07:34:41.372] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:4:0)
[07:34:41.396] Build status: STARTED
[07:34:41.396] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:5:0) after 4m43s
[07:39:24.398] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:5:0)
[07:39:24.419] Build status: STARTED
[07:39:24.419] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:6:0) after 9m49s
[07:49:13.439] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:6:0)
[07:49:13.475] Build status: STARTED
[07:49:13.475] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:7:0) after 6m31s
[07:55:44.495] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:7:0)
[07:55:44.537] Build status: STARTED
[07:55:44.537] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:8:0) after 5m34s
[08:01:18.566] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:8:0)
[08:01:18.588] Build status: STARTED
[08:01:18.588] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:9:0) after 9m1s
[08:10:19.606] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:9:0)
[08:10:19.694] Build status: STARTED
[08:10:19.694] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:10:0) after 1m8s
[08:11:27.718] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:10:0)
[08:11:27.741] Build status: STARTED
[08:11:27.741] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:11:0) after 6m6s
[08:17:33.940] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:11:0)
[08:17:33.978] Build status: STARTED
[08:17:33.978] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:12:0) after 9m58s
[08:27:32.039] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:12:0)
[08:27:32.061] Build status: STARTED
[08:27:32.061] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:13:0) after 1m26s
[08:28:58.149] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:13:0)
[08:28:58.174] Build status: STARTED
[08:28:58.174] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:14:0) after 9m58s
[08:38:56.160] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:14:0)
[08:38:56.182] Build status: STARTED
[08:38:56.182] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:15:0) after 3m33s
[08:42:29.276] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:15:0)
[08:42:29.297] Build status: STARTED
[08:42:29.297] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:16:0) after 2m19s
[08:44:48.337] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:16:0)
[08:44:48.358] Build status: STARTED
[08:44:48.358] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:17:0) after 7m5s
[08:51:53.421] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:17:0)
[08:51:53.450] Build status: STARTED
[08:51:53.450] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:18:0) after 6m29s
[08:58:22.474] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:18:0)
[08:58:22.496] Build status: STARTED
[08:58:22.496] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:19:0) after 5m48s
[09:04:10.742] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:19:0)
[09:04:10.798] Build status: STARTED
[09:04:10.798] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:20:0) after 1m29s
[09:05:39.962] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:20:0)
[09:05:39.989] Build status: STARTED
[09:05:39.989] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:21:0) after 2m9s
[09:07:49.106] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:21:0)
[09:07:49.125] Build status: STARTED
[09:07:49.125] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:22:0) after 8m57s
[09:16:46.206] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:22:0)
[09:16:46.239] Build status: STARTED
[09:16:46.239] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:23:0) after 4m48s
[09:21:34.388] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:23:0)
[09:21:34.442] Build status: STARTED
[09:21:34.442] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:24:0) after 8m52s
[09:30:26.665] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:24:0)
[09:30:26.694] Build status: STARTED
[09:30:26.694] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:25:0) after 9m18s
[09:39:44.718] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:25:0)
[09:39:44.738] Build status: STARTED
[09:39:44.738] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:26:0) after 9m43s
[09:49:27.990] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:26:0)
[09:49:28.014] Build status: STARTED
[09:49:28.014] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:27:0) after 3m52s
[09:53:20.181] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:27:0)
[09:53:20.202] Build status: STARTED
[09:53:20.202] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:28:0) after 5m59s
[09:59:19.413] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:28:0)
[09:59:19.446] Build status: STARTED
[09:59:19.446] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:29:0) after 3m19s
[10:02:38.735] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:29:0)
[10:02:38.787] Build status: STARTED
[10:02:38.787] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:30:0) after 7m57s
[10:10:35.963] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:30:0)
[10:10:36.146] Build status: STARTED
[10:10:36.146] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:31:0) after 8m54s
[10:19:30.272] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:31:0)
[10:19:30.295] Build status: STARTED
[10:19:30.295] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:32:0) after 7m53s
[10:27:23.605] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:32:0)
[10:27:23.625] Build status: STARTED
[10:27:23.625] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:33:0) after 6m35s
[10:33:58.787] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:33:0)
[10:33:58.809] Build status: STARTED
[10:33:58.810] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:34:0) after 7m53s
[10:41:51.881] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:34:0)
[10:41:51.902] Build status: STARTED
[10:41:51.902] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:35:0) after 6m25s
[10:48:17.167] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:35:0)
[10:48:17.188] Build status: STARTED
[10:48:17.188] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:36:0) after 1m4s
[10:49:21.272] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:36:0)
[10:49:21.359] Build status: STARTED
[10:49:21.359] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:37:0) after 7m50s
[10:57:11.903] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:37:0)
[10:57:11.923] Build status: STARTED
[10:57:11.923] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:38:0) after 5m20s
[11:02:32.200] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:38:0)
[11:02:32.225] Build status: STARTED
[11:02:32.225] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:39:0) after 3m34s
[11:06:06.306] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:39:0)
[11:06:06.336] Build status: STARTED
[11:06:06.336] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:40:0) after 9m8s
[11:15:14.701] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:40:0)
[11:15:14.729] Build status: STARTED
[11:15:14.729] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:41:0) after 3m47s
[11:19:01.857] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:41:0)
[11:19:01.884] Build status: STARTED
[11:19:01.884] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:42:0) after 3m37s
[11:22:39.090] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:42:0)
[11:22:39.113] Build status: STARTED
[11:22:39.113] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:43:0) after 1m0s
[11:23:39.136] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:43:0)
[11:23:39.157] Build status: STARTED
[11:23:39.157] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:44:0) after 1m5s
[11:24:44.193] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:44:0)
[11:24:44.214] Build status: STARTED
[11:24:44.214] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:45:0) after 9m57s
[11:34:41.238] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:45:0)
[11:34:41.291] Build status: STARTED
[11:34:41.291] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:46:0) after 5m44s
[11:40:25.614] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:46:0)
[11:40:25.637] Build status: STARTED
[11:40:25.637] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:47:0) after 9m29s
[11:49:54.660] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:47:0)
[11:49:54.693] Build status: STARTED
[11:49:54.693] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:48:0) after 4m9s
[11:54:03.817] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:48:0)
[11:54:03.841] Build status: STARTED
[11:54:03.841] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:49:0) after 5m4s
[11:59:08.036] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:49:0)
[11:59:08.060] Build status: STARTED
[11:59:08.060] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:50:0) after 9m57s
[12:09:05.077] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:50:0)
[12:09:05.112] Build status: STARTED
[12:09:05.112] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:51:0) after 6m57s
[12:16:02.718] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:51:0)
[12:16:02.741] Build status: STARTED
[12:16:02.741] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:52:0) after 6m31s
[12:22:33.860] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:52:0)
[12:22:33.918] Build status: STARTED
[12:22:33.918] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:53:0) after 6m19s
[12:28:53.058] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:53:0)
[12:28:53.141] Build status: STARTED
[12:28:53.141] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:54:0) after 9m31s
[12:38:24.258] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:54:0)
[12:38:24.286] Build status: STARTED
[12:38:24.286] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:55:0) after 6m36s
[12:45:00.406] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:55:0)
[12:45:00.423] Build status: STARTED
[12:45:00.423] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:56:0) after 3m34s
[12:48:34.480] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:56:0)
[12:48:34.512] Build status: STARTED
[12:48:34.512] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:57:0) after 6m23s
[12:54:57.538] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:57:0)
[12:54:57.558] Build status: STARTED
[12:54:57.558] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:58:0) after 1m11s
[12:56:08.600] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:58:0)
[12:56:08.713] Build status: STARTED
[12:56:08.713] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:59:0) after 9m29s
[13:05:37.749] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:59:0)
[13:05:37.772] Build status: STARTED
[13:05:37.772] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:60:0) after 2m44s
[13:08:21.803] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:60:0)
[13:08:21.850] Build status: STARTED
[13:08:21.850] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:61:0) after 9m17s
[13:17:39.471] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:61:0)
[13:17:39.493] Build status: STARTED
[13:17:39.493] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:62:0) after 3m43s
[13:21:22.520] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:62:0)
[13:21:22.539] Build status: STARTED
[13:21:22.539] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:63:0) after 3m49s
[13:25:11.689] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:63:0)
[13:25:11.711] Build status: STARTED
[13:25:11.711] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:64:0) after 2m36s
[13:27:48.067] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:64:0)
[13:27:48.088] Build status: STARTED
[13:27:48.088] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:65:0) after 9m30s
[13:37:18.136] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:65:0)
[13:37:18.172] Build status: STARTED
[13:37:18.172] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:66:0) after 3m28s
[13:40:46.207] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:66:0)
[13:40:46.226] Build status: STARTED
[13:40:46.226] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:67:0) after 5m45s
[13:46:31.277] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:67:0)
[13:46:31.303] Build status: STARTED
[13:46:31.303] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:68:0) after 3m28s
[13:49:59.493] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:68:0)
[13:49:59.600] Build status: STARTED
[13:49:59.600] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:69:0) after 1m57s
[13:51:56.759] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:69:0)
[13:51:56.779] Build status: STARTED
[13:51:56.779] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:70:0) after 7m43s
[13:59:39.883] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:70:0)
[13:59:39.909] Build status: STARTED
[13:59:39.909] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:71:0) after 7m39s
[14:07:18.963] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:71:0)
[14:07:18.982] Build status: STARTED
[14:07:18.982] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:72:0) after 1m12s
[14:08:31.195] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:72:0)
[14:08:31.234] Build status: STARTED
[14:08:31.234] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:73:0) after 8m10s
[14:16:41.513] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:73:0)
[14:16:41.538] Build status: STARTED
[14:16:41.538] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:74:0) after 6m10s
[14:22:51.721] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:74:0)
[14:22:51.747] Build status: STARTED
[14:22:51.747] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:75:0) after 3m17s
[14:26:08.822] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:75:0)
[14:26:08.857] Build status: STARTED
[14:26:08.857] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:76:0) after 5m32s
[14:31:40.934] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:76:0)
[14:31:40.967] Build status: STARTED
[14:31:40.967] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:77:0) after 4m35s
[14:36:15.989] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:77:0)
[14:36:16.017] Build status: STARTED
[14:36:16.017] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:78:0) after 4m56s
[14:41:12.040] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:78:0)
[14:41:12.062] Build status: STARTED
[14:41:12.062] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:79:0) after 1m35s
[14:42:47.082] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:79:0)
[14:42:47.108] Build status: STARTED
[14:42:47.108] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:80:0) after 8m37s
[14:51:24.210] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:80:0)
[14:51:24.231] Build status: STARTED
[14:51:24.231] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:81:0) after 5m35s
[14:56:59.251] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:81:0)
[14:56:59.284] Build status: STARTED
[14:56:59.284] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:82:0) after 2m2s
[14:59:01.320] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:82:0)
[14:59:01.362] Build status: STARTED
[14:59:01.362] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:83:0) after 7m32s
[15:06:33.902] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:83:0)
[15:06:33.926] Build status: STARTED
[15:06:33.926] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:84:0) after 5m54s
[15:12:27.961] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:84:0)
[15:12:27.982] Build status: STARTED
[15:12:27.982] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:85:0) after 1m0s
[15:13:28.194] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:85:0)
[15:13:28.222] Build status: STARTED
[15:13:28.222] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:86:0) after 5m55s
[15:19:23.303] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:86:0)
[15:19:23.348] Build status: STARTED
[15:19:23.348] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:87:0) after 5m27s
[15:24:50.706] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:87:0)
[15:24:50.838] Build status: STARTED
[15:24:50.838] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:88:0) after 5m36s
[15:30:26.847] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:88:0)
[15:30:26.928] Build status: STARTED
[15:30:26.928] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:89:0) after 1m49s
[15:32:16.802] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:89:0)
[15:32:16.827] Build status: STARTED
[15:32:16.827] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:90:0) after 1m46s
[15:34:02.837] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:90:0)
[15:34:02.859] Build status: STARTED
[15:34:02.859] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:91:0) after 9m54s
[15:43:56.896] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:91:0)
[15:43:56.932] Build status: STARTED
[15:43:56.932] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:92:0) after 9m30s
[15:53:27.242] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:92:0)
[15:53:27.293] Build status: STARTED
[15:53:27.293] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:93:0) after 2m37s
[15:56:04.564] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:93:0)
[15:56:04.585] Build status: STARTED
[15:56:04.585] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:94:0) after 9m7s
[16:05:11.784] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:94:0)
[16:05:11.859] Build status: STARTED
[16:05:11.859] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:95:0) after 2m5s
[16:07:16.964] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:95:0)
[16:07:16.986] Build status: STARTED
[16:07:16.986] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:96:0) after 6m8s
[16:13:25.066] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:96:0)
[16:13:25.093] Build status: STARTED
[16:13:25.093] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:97:0) after 1m50s
[16:15:15.284] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:97:0)
[16:15:15.308] Build status: STARTED
[16:15:15.308] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:98:0) after 6m37s
[16:21:52.484] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:98:0)
[16:21:52.508] Build status: STARTED
[16:21:52.508] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:99:0) after 9m31s
[16:31:23.545] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:99:0)
[16:31:23.571] Build status: STARTED
[16:31:23.571] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:100:0) after 8m31s
[16:39:54.634] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:100:0)
[16:39:54.658] Build status: STARTED
[16:39:54.659] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:101:0) after 9m48s
[16:49:42.689] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:101:0)
[16:49:42.716] Build status: STARTED
[16:49:42.716] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:102:0) after 1m48s
[16:51:30.750] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:102:0)
[16:51:30.777] Build status: STARTED
[16:51:30.777] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:103:0) after 3m19s
[16:54:49.780] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:103:0)
[16:54:49.804] Build status: STARTED
[16:54:49.804] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:104:0) after 2m32s
[16:57:22.156] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:104:0)
[16:57:22.285] Build status: STARTED
[16:57:22.285] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:105:0) after 9m25s
[17:06:47.452] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:105:0)
[17:06:47.472] Build status: STARTED
[17:06:47.472] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:106:0) after 7m50s
[17:14:37.549] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:106:0)
[17:14:37.571] Build status: STARTED
[17:14:37.571] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:107:0) after 3m37s
[17:18:14.604] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:107:0)
[17:18:14.642] Build status: STARTED
[17:18:14.642] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:108:0) after 6m19s
[17:24:33.667] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:108:0)
[17:24:33.696] Build status: STARTED
[17:24:33.696] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:109:0) after 6m3s
[17:30:36.728] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:109:0)
[17:30:36.746] Build status: STARTED
[17:30:36.746] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:110:0) after 9m45s
[17:40:21.903] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:110:0)
[17:40:21.925] Build status: STARTED
[17:40:21.925] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:111:0) after 4m7s
[17:44:29.284] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:111:0)
[17:44:29.344] Build status: STARTED
[17:44:29.344] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:112:0) after 4m26s
[17:48:55.368] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:112:0)
[17:48:55.394] Build status: STARTED
[17:48:55.394] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:113:0) after 9m57s
[17:58:52.523] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:113:0)
[17:58:52.547] Build status: STARTED
[17:58:52.548] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:114:0) after 8m36s
[18:07:28.615] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:114:0)
[18:07:28.643] Build status: STARTED
[18:07:28.643] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:115:0) after 8m22s
[18:15:50.756] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:115:0)
[18:15:50.781] Build status: STARTED
[18:15:50.782] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:116:0) after 7m51s
[18:23:41.835] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:116:0)
[18:23:41.860] Build status: STARTED
[18:23:41.860] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:117:0) after 3m5s
[18:26:46.892] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:117:0)
[18:26:46.935] Build status: STARTED
[18:26:46.935] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:118:0) after 8m8s
[18:34:55.016] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:118:0)
[18:34:55.041] Build status: STARTED
[18:34:55.041] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:119:0) after 5m30s
[18:40:25.070] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:119:0)
[18:40:25.119] Build status: STARTED
[18:40:25.119] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:120:0) after 1m26s
[18:41:51.618] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:120:0)
[18:41:51.640] Build status: STARTED
[18:41:51.640] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:121:0) after 3m16s
[18:45:08.064] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:121:0)
[18:45:08.091] Build status: STARTED
[18:45:08.091] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:122:0) after 4m6s
[18:49:14.120] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:122:0)
[18:49:14.197] Build status: STARTED
[18:49:14.197] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956898812179181904:123:0) after 9m6s
[18:56:59.249] Received PubSub notification, asking Buildbucket for the build status
[18:56:59.276] Build:
{
"id": "8791468750050148545",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "CFI Linux ToT"
},
"number": 17880,
"createdBy": "project:chromium",
"createTime": "2023-01-20T07:17:51.797892554Z",
"startTime": "2023-01-20T07:19:22.618462Z",
"endTime": "2023-01-20T18:56:58.966758951Z",
"updateTime": "2023-01-20T18:56:58.966758951Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "db38b1c1c0c12bee94f2b58ca5d8f74245059fec",
"ref": "refs/heads/main"
}
}
}
[18:56:59.276] Invocation finished in 11h39m8.893083717s with status FAILED