[07:25:59.459] New invocation is queued and will start shortly
[07:26:00.724] Starting the invocation (attempt 1)
[07:26:00.764] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/03dc2fcc83223f656ef53b98ac3bd6146ab64919"
[07:26:00.764] Popped gitiles commit info from properties and tags
[07:26:00.764] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:26:00.764] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:26:00.765] Buildbucket request:
{
"requestId": "8987157686138172320",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "03dc2fcc83223f656ef53b98ac3bd6146ab64919",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8987157686138172320"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTMac"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[07:26:01.260] Scheduled build:
{
"id": "8821727624034864193",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac"
},
"number": 27538,
"createdBy": "project:chromium",
"createTime": "2022-02-20T07:26:00.834555386Z",
"updateTime": "2022-02-20T07:26:00.834555386Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "03dc2fcc83223f656ef53b98ac3bd6146ab64919",
"ref": "refs/heads/main"
}
}
}
[07:26:01.260] Task URL: https://cr-buildbucket.appspot.com/build/8821727624034864193
[07:26:01.260] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:2:0) after 7m48s
[07:33:49.332] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:2:0)
[07:33:49.360] Build status: SCHEDULED
[07:33:49.360] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:3:0) after 3m8s
[07:36:58.068] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:3:0)
[07:36:58.085] Build status: SCHEDULED
[07:36:58.085] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:4:0) after 8m9s
[07:45:07.103] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:4:0)
[07:45:07.119] Build status: SCHEDULED
[07:45:07.119] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:5:0) after 6m6s
[07:51:13.250] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:5:0)
[07:51:13.275] Build status: SCHEDULED
[07:51:13.275] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:6:0) after 2m39s
[07:53:52.292] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:6:0)
[07:53:52.319] Build status: SCHEDULED
[07:53:52.319] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:7:0) after 1m30s
[07:55:22.452] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:7:0)
[07:55:22.478] Build status: SCHEDULED
[07:55:22.478] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:8:0) after 2m43s
[07:58:06.068] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:8:0)
[07:58:06.086] Build status: SCHEDULED
[07:58:06.086] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:9:0) after 3m50s
[08:01:56.104] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:9:0)
[08:01:56.128] Build status: SCHEDULED
[08:01:56.128] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:10:0) after 8m26s
[08:06:41.921] Received PubSub notification, asking Buildbucket for the build status
[08:06:41.949] Build status: STARTED
[08:10:22.139] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:10:0)
[08:10:22.169] Build status: STARTED
[08:10:22.169] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:12:0) after 6m35s
[08:16:57.186] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:12:0)
[08:16:57.204] Build status: STARTED
[08:16:57.204] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:13:0) after 6m39s
[08:23:36.369] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:13:0)
[08:23:36.395] Build status: STARTED
[08:23:36.395] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:14:0) after 3m31s
[08:27:07.492] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:14:0)
[08:27:07.521] Build status: STARTED
[08:27:07.521] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:15:0) after 7m33s
[08:34:40.783] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:15:0)
[08:34:40.811] Build status: STARTED
[08:34:40.811] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:16:0) after 6m41s
[08:41:21.814] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:16:0)
[08:41:21.842] Build status: STARTED
[08:41:21.842] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:17:0) after 8m15s
[08:49:37.075] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:17:0)
[08:49:37.104] Build status: STARTED
[08:49:37.104] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:18:0) after 3m27s
[08:53:04.128] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:18:0)
[08:53:04.157] Build status: STARTED
[08:53:04.157] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:19:0) after 1m14s
[08:54:18.176] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:19:0)
[08:54:18.200] Build status: STARTED
[08:54:18.200] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:20:0) after 3m7s
[08:57:25.219] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:20:0)
[08:57:25.247] Build status: STARTED
[08:57:25.247] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:21:0) after 8m43s
[09:06:08.290] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:21:0)
[09:06:08.308] Build status: STARTED
[09:06:08.308] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:22:0) after 8m53s
[09:15:01.497] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:22:0)
[09:15:01.552] Build status: STARTED
[09:15:01.552] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:23:0) after 1m41s
[09:16:42.538] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:23:0)
[09:16:42.672] Build status: STARTED
[09:16:42.672] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:24:0) after 4m52s
[09:21:34.689] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:24:0)
[09:21:34.727] Build status: STARTED
[09:21:34.727] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:25:0) after 4m48s
[09:26:22.899] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:25:0)
[09:26:22.981] Build status: STARTED
[09:26:22.981] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:26:0) after 9m36s
[09:35:59.554] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:26:0)
[09:35:59.583] Build status: STARTED
[09:35:59.583] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:27:0) after 5m6s
[09:41:05.860] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:27:0)
[09:41:05.881] Build status: STARTED
[09:41:05.881] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:28:0) after 5m40s
[09:46:46.587] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:28:0)
[09:46:46.609] Build status: STARTED
[09:46:46.609] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:29:0) after 4m56s
[09:51:42.914] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:29:0)
[09:51:42.946] Build status: STARTED
[09:51:42.946] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:30:0) after 4m31s
[09:56:14.028] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:30:0)
[09:56:14.054] Build status: STARTED
[09:56:14.054] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:31:0) after 2m15s
[09:58:29.202] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:31:0)
[09:58:29.233] Build status: STARTED
[09:58:29.233] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:32:0) after 6m7s
[10:04:36.258] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:32:0)
[10:04:36.284] Build status: STARTED
[10:04:36.284] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:33:0) after 7m57s
[10:12:33.423] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:33:0)
[10:12:33.441] Build status: STARTED
[10:12:33.441] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:34:0) after 2m39s
[10:15:12.561] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:34:0)
[10:15:12.584] Build status: STARTED
[10:15:12.584] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:35:0) after 2m22s
[10:17:34.599] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:35:0)
[10:17:34.622] Build status: STARTED
[10:17:34.622] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:36:0) after 6m51s
[10:24:27.087] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:36:0)
[10:24:27.107] Build status: STARTED
[10:24:27.107] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:37:0) after 8m44s
[10:33:11.172] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:37:0)
[10:33:11.198] Build status: STARTED
[10:33:11.198] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:38:0) after 4m11s
[10:37:22.216] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:38:0)
[10:37:22.246] Build status: STARTED
[10:37:22.246] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:39:0) after 3m50s
[10:41:12.364] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:39:0)
[10:41:12.401] Build status: STARTED
[10:41:12.401] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:40:0) after 9m34s
[10:50:46.628] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:40:0)
[10:50:46.649] Build status: STARTED
[10:50:46.649] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:41:0) after 9m36s
[11:00:22.682] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:41:0)
[11:00:22.716] Build status: STARTED
[11:00:22.716] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:42:0) after 1m53s
[11:02:15.737] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:42:0)
[11:02:15.760] Build status: STARTED
[11:02:15.760] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:43:0) after 4m49s
[11:07:04.997] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:43:0)
[11:07:05.046] Build status: STARTED
[11:07:05.046] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:44:0) after 6m3s
[11:13:08.102] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:44:0)
[11:13:08.140] Build status: STARTED
[11:13:08.140] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:45:0) after 5m5s
[11:18:13.283] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:45:0)
[11:18:13.303] Build status: STARTED
[11:18:13.303] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:46:0) after 8m40s
[11:26:53.384] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:46:0)
[11:26:53.406] Build status: STARTED
[11:26:53.406] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:47:0) after 3m6s
[11:29:59.424] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:47:0)
[11:29:59.481] Build status: STARTED
[11:29:59.481] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:48:0) after 7m49s
[11:37:49.221] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:48:0)
[11:37:49.251] Build status: STARTED
[11:37:49.251] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:49:0) after 8m54s
[11:46:43.271] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:49:0)
[11:46:43.290] Build status: STARTED
[11:46:43.290] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:50:0) after 4m35s
[11:51:18.432] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:50:0)
[11:51:18.466] Build status: STARTED
[11:51:18.466] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:51:0) after 3m46s
[11:55:04.886] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:51:0)
[11:55:04.905] Build status: STARTED
[11:55:04.905] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:52:0) after 1m6s
[11:56:11.324] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:52:0)
[11:56:11.346] Build status: STARTED
[11:56:11.346] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:53:0) after 4m39s
[12:00:50.814] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:53:0)
[12:00:50.849] Build status: STARTED
[12:00:50.849] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:54:0) after 2m9s
[12:03:00.214] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:54:0)
[12:03:00.261] Build status: STARTED
[12:03:00.261] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:55:0) after 5m56s
[12:08:56.291] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:55:0)
[12:08:56.309] Build status: STARTED
[12:08:56.309] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:56:0) after 2m33s
[12:11:29.477] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:56:0)
[12:11:29.504] Build status: STARTED
[12:11:29.504] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:57:0) after 1m11s
[12:12:40.524] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:57:0)
[12:12:40.555] Build status: STARTED
[12:12:40.555] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:58:0) after 2m0s
[12:14:40.573] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:58:0)
[12:14:40.593] Build status: STARTED
[12:14:40.593] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:59:0) after 4m46s
[12:19:26.774] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:59:0)
[12:19:26.804] Build status: STARTED
[12:19:26.804] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:60:0) after 4m23s
[12:23:49.934] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:60:0)
[12:23:49.962] Build status: STARTED
[12:23:49.962] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:61:0) after 2m14s
[12:26:03.987] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:61:0)
[12:26:04.024] Build status: STARTED
[12:26:04.024] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:62:0) after 9m53s
[12:35:57.305] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:62:0)
[12:35:57.340] Build status: STARTED
[12:35:57.340] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:63:0) after 3m55s
[12:39:52.596] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:63:0)
[12:39:52.616] Build status: STARTED
[12:39:52.616] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:64:0) after 3m21s
[12:43:13.639] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:64:0)
[12:43:13.667] Build status: STARTED
[12:43:13.667] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:65:0) after 1m46s
[12:44:59.738] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:65:0)
[12:44:59.792] Build status: STARTED
[12:44:59.792] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:66:0) after 8m31s
[12:53:31.671] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:66:0)
[12:53:31.713] Build status: STARTED
[12:53:31.713] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:67:0) after 7m27s
[13:00:58.734] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:67:0)
[13:00:58.778] Build status: STARTED
[13:00:58.778] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:68:0) after 9m17s
[13:10:16.025] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:68:0)
[13:10:16.122] Build status: STARTED
[13:10:16.122] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:69:0) after 2m42s
[13:12:58.289] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:69:0)
[13:12:58.308] Build status: STARTED
[13:12:58.308] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:70:0) after 3m4s
[13:16:02.463] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:70:0)
[13:16:02.492] Build status: STARTED
[13:16:02.492] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:71:0) after 2m30s
[13:18:32.513] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:71:0)
[13:18:32.534] Build status: STARTED
[13:18:32.534] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:72:0) after 8m19s
[13:26:51.679] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:72:0)
[13:26:51.709] Build status: STARTED
[13:26:51.709] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:73:0) after 6m48s
[13:33:39.747] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:73:0)
[13:33:39.774] Build status: STARTED
[13:33:39.774] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:74:0) after 6m43s
[13:40:22.796] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:74:0)
[13:40:22.828] Build status: STARTED
[13:40:22.828] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:75:0) after 7m20s
[13:47:43.949] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:75:0)
[13:47:43.972] Build status: STARTED
[13:47:43.972] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:76:0) after 9m29s
[13:57:12.991] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:76:0)
[13:57:13.010] Build status: STARTED
[13:57:13.010] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:77:0) after 3m5s
[14:00:18.033] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:77:0)
[14:00:18.055] Build status: STARTED
[14:00:18.055] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:78:0) after 2m54s
[14:03:12.077] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:78:0)
[14:03:12.172] Build status: STARTED
[14:03:12.172] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:79:0) after 5m52s
[14:09:04.246] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:79:0)
[14:09:04.265] Build status: STARTED
[14:09:04.265] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:80:0) after 4m35s
[14:13:39.286] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:80:0)
[14:13:39.320] Build status: STARTED
[14:13:39.320] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:81:0) after 2m34s
[14:16:13.341] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:81:0)
[14:16:13.359] Build status: STARTED
[14:16:13.359] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:82:0) after 8m15s
[14:24:28.378] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:82:0)
[14:24:28.399] Build status: STARTED
[14:24:28.399] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:83:0) after 8m39s
[14:33:07.448] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:83:0)
[14:33:07.471] Build status: STARTED
[14:33:07.471] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:84:0) after 9m42s
[14:42:49.695] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:84:0)
[14:42:49.718] Build status: STARTED
[14:42:49.718] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:85:0) after 9m21s
[14:52:10.769] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:85:0)
[14:52:10.797] Build status: STARTED
[14:52:10.797] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:86:0) after 4m10s
[14:56:20.814] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:86:0)
[14:56:20.873] Build status: STARTED
[14:56:20.873] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:87:0) after 9m52s
[15:06:12.902] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:87:0)
[15:06:12.924] Build status: STARTED
[15:06:12.924] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:88:0) after 8m8s
[15:14:21.530] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:88:0)
[15:14:21.559] Build status: STARTED
[15:14:21.559] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:89:0) after 3m33s
[15:17:54.873] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:89:0)
[15:17:54.892] Build status: STARTED
[15:17:54.892] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:90:0) after 8m57s
[15:26:51.968] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:90:0)
[15:26:51.986] Build status: STARTED
[15:26:51.986] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:91:0) after 9m4s
[15:35:56.781] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:91:0)
[15:35:56.801] Build status: STARTED
[15:35:56.801] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:92:0) after 1m13s
[15:37:10.576] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:92:0)
[15:37:10.596] Build status: STARTED
[15:37:10.596] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:93:0) after 5m14s
[15:42:24.636] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:93:0)
[15:42:24.706] Build status: STARTED
[15:42:24.706] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:94:0) after 8m39s
[15:51:03.708] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:94:0)
[15:51:03.731] Build status: STARTED
[15:51:03.731] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:95:0) after 6m11s
[15:57:14.832] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:95:0)
[15:57:14.854] Build status: STARTED
[15:57:14.854] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:96:0) after 6m17s
[16:03:31.879] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:96:0)
[16:03:31.907] Build status: STARTED
[16:03:31.907] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:97:0) after 4m36s
[16:08:08.028] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:97:0)
[16:08:08.047] Build status: STARTED
[16:08:08.047] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:98:0) after 7m46s
[16:15:54.345] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:98:0)
[16:15:54.364] Build status: STARTED
[16:15:54.364] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:99:0) after 5m4s
[16:20:58.383] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:99:0)
[16:20:58.406] Build status: STARTED
[16:20:58.406] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:100:0) after 3m49s
[16:24:47.560] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:100:0)
[16:24:47.580] Build status: STARTED
[16:24:47.580] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:101:0) after 9m48s
[16:34:35.599] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:101:0)
[16:34:35.618] Build status: STARTED
[16:34:35.618] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:102:0) after 4m9s
[16:38:44.639] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:102:0)
[16:38:44.671] Build status: STARTED
[16:38:44.671] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:103:0) after 4m19s
[16:43:03.691] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:103:0)
[16:43:03.713] Build status: STARTED
[16:43:03.713] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:104:0) after 3m49s
[16:46:53.013] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:104:0)
[16:46:53.041] Build status: STARTED
[16:46:53.041] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:105:0) after 5m34s
[16:52:27.169] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:105:0)
[16:52:27.190] Build status: STARTED
[16:52:27.190] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:106:0) after 1m3s
[16:53:30.210] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:106:0)
[16:53:30.256] Build status: STARTED
[16:53:30.256] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:107:0) after 6m59s
[17:00:29.279] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:107:0)
[17:00:29.300] Build status: STARTED
[17:00:29.300] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:108:0) after 7m48s
[17:08:17.472] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:108:0)
[17:08:17.497] Build status: STARTED
[17:08:17.497] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:109:0) after 8m49s
[17:17:06.636] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:109:0)
[17:17:06.657] Build status: STARTED
[17:17:06.657] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:110:0) after 1m25s
[17:18:31.812] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:110:0)
[17:18:31.841] Build status: STARTED
[17:18:31.841] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:111:0) after 5m23s
[17:23:54.957] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:111:0)
[17:23:54.988] Build status: STARTED
[17:23:54.988] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:112:0) after 1m29s
[17:25:23.988] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:112:0)
[17:25:24.007] Build status: STARTED
[17:25:24.007] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:113:0) after 4m11s
[17:29:35.149] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:113:0)
[17:29:35.180] Build status: STARTED
[17:29:35.180] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:114:0) after 9m14s
[17:38:49.202] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:114:0)
[17:38:49.225] Build status: STARTED
[17:38:49.225] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:115:0) after 8m38s
[17:47:27.256] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:115:0)
[17:47:27.280] Build status: STARTED
[17:47:27.281] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:116:0) after 6m59s
[17:54:26.377] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:116:0)
[17:54:26.399] Build status: STARTED
[17:54:26.399] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:117:0) after 2m12s
[17:56:38.567] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:117:0)
[17:56:38.627] Build status: STARTED
[17:56:38.627] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:118:0) after 9m35s
[18:06:13.650] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:118:0)
[18:06:13.687] Build status: STARTED
[18:06:13.687] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:119:0) after 6m38s
[18:12:51.705] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:119:0)
[18:12:51.739] Build status: STARTED
[18:12:51.739] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:120:0) after 1m51s
[18:14:43.850] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:120:0)
[18:14:43.887] Build status: STARTED
[18:14:43.887] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:121:0) after 8m54s
[18:23:38.064] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:121:0)
[18:23:38.087] Build status: STARTED
[18:23:38.087] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:122:0) after 7m5s
[18:30:43.267] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:122:0)
[18:30:43.362] Build status: STARTED
[18:30:43.362] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:123:0) after 4m41s
[18:35:24.398] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:123:0)
[18:35:24.418] Build status: STARTED
[18:35:24.418] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:124:0) after 5m29s
[18:40:53.442] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:124:0)
[18:40:53.479] Build status: STARTED
[18:40:53.479] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:125:0) after 6m20s
[18:47:13.503] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:125:0)
[18:47:13.525] Build status: STARTED
[18:47:13.525] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:126:0) after 8m9s
[18:55:22.670] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:126:0)
[18:55:22.704] Build status: STARTED
[18:55:22.704] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8987157686138172320:127:0) after 2m53s
[18:58:05.834] Received PubSub notification, asking Buildbucket for the build status
[18:58:05.871] Build:
{
"id": "8821727624034864193",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac"
},
"number": 27538,
"createdBy": "project:chromium",
"createTime": "2022-02-20T07:26:00.834555386Z",
"startTime": "2022-02-20T08:06:40.266237Z",
"endTime": "2022-02-20T18:58:05.397034965Z",
"updateTime": "2022-02-20T18:58:05.397034965Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "03dc2fcc83223f656ef53b98ac3bd6146ab64919",
"ref": "refs/heads/main"
}
}
}
[18:58:05.871] Invocation finished in 11h32m6.425537057s with status FAILED