[16:23:42.455] New invocation is queued and will start shortly
[16:23:43.625] Starting the invocation (attempt 1)
[16:23:43.693] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/df6422f22ec542fdf2d19c99ca543a90553969f5"
[16:23:43.693] Popped gitiles commit info from properties and tags
[16:23:43.693] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:23:43.693] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:23:43.693] Buildbucket request:
{
"requestId": "9002434743266129248",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac (dbg)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "df6422f22ec542fdf2d19c99ca543a90553969f5",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9002434743266129248"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTMac (dbg)"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[16:23:44.227] Scheduled build:
{
"id": "8837004681236447089",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac (dbg)"
},
"number": 27115,
"createdBy": "project:chromium",
"createTime": "2021-09-04T16:23:43.751305302Z",
"updateTime": "2021-09-04T16:23:44.040019680Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "df6422f22ec542fdf2d19c99ca543a90553969f5",
"ref": "refs/heads/main"
}
}
}
[16:23:44.227] Task URL: https://cr-buildbucket.appspot.com/build/8837004681236447089
[16:23:44.227] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:2:0) after 7m44s
[16:23:57.231] Received PubSub notification, asking Buildbucket for the build status
[16:23:57.261] Build status: STARTED
[16:31:28.212] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:2:0)
[16:31:28.245] Build status: STARTED
[16:31:28.245] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:4:0) after 1m41s
[16:33:09.344] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:4:0)
[16:33:09.376] Build status: STARTED
[16:33:09.376] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:5:0) after 6m2s
[16:39:11.535] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:5:0)
[16:39:11.579] Build status: STARTED
[16:39:11.579] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:6:0) after 9m51s
[16:49:02.612] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:6:0)
[16:49:02.664] Build status: STARTED
[16:49:02.664] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:7:0) after 6m2s
[16:55:06.498] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:7:0)
[16:55:06.535] Build status: STARTED
[16:55:06.535] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:8:0) after 1m7s
[16:56:14.424] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:8:0)
[16:56:14.501] Build status: STARTED
[16:56:14.501] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:9:0) after 6m48s
[17:03:02.619] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:9:0)
[17:03:02.649] Build status: STARTED
[17:03:02.649] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:10:0) after 2m50s
[17:05:52.665] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:10:0)
[17:05:52.701] Build status: STARTED
[17:05:52.701] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:11:0) after 1m29s
[17:07:21.720] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:11:0)
[17:07:21.747] Build status: STARTED
[17:07:21.747] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:12:0) after 3m58s
[17:11:19.766] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:12:0)
[17:11:19.808] Build status: STARTED
[17:11:19.808] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:13:0) after 4m32s
[17:15:52.055] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:13:0)
[17:15:52.087] Build status: STARTED
[17:15:52.087] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:14:0) after 9m54s
[17:25:46.131] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:14:0)
[17:25:46.164] Build status: STARTED
[17:25:46.164] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:15:0) after 7m13s
[17:32:59.377] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:15:0)
[17:32:59.408] Build status: STARTED
[17:32:59.408] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:16:0) after 1m3s
[17:34:02.623] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:16:0)
[17:34:02.651] Build status: STARTED
[17:34:02.651] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:17:0) after 1m40s
[17:35:42.672] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:17:0)
[17:35:42.705] Build status: STARTED
[17:35:42.705] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:18:0) after 9m38s
[17:45:20.942] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:18:0)
[17:45:20.975] Build status: STARTED
[17:45:20.975] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:19:0) after 9m57s
[17:55:18.961] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:19:0)
[17:55:19.016] Build status: STARTED
[17:55:19.016] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:20:0) after 9m9s
[18:04:28.078] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:20:0)
[18:04:28.133] Build status: STARTED
[18:04:28.133] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:21:0) after 2m14s
[18:06:42.157] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:21:0)
[18:06:42.193] Build status: STARTED
[18:06:42.193] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:22:0) after 4m12s
[18:10:54.223] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:22:0)
[18:10:54.251] Build status: STARTED
[18:10:54.251] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:23:0) after 2m1s
[18:12:55.268] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:23:0)
[18:12:55.302] Build status: STARTED
[18:12:55.302] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:24:0) after 9m17s
[18:22:12.367] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:24:0)
[18:22:12.476] Build status: STARTED
[18:22:12.476] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:25:0) after 1m29s
[18:23:41.631] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:25:0)
[18:23:41.662] Build status: STARTED
[18:23:41.662] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:26:0) after 6m26s
[18:30:07.790] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:26:0)
[18:30:07.830] Build status: STARTED
[18:30:07.830] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:27:0) after 4m5s
[18:34:12.865] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:27:0)
[18:34:12.894] Build status: STARTED
[18:34:12.894] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:28:0) after 8m32s
[18:42:44.952] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:28:0)
[18:42:44.998] Build status: STARTED
[18:42:44.998] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:29:0) after 8m58s
[18:51:43.195] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:29:0)
[18:51:43.222] Build status: STARTED
[18:51:43.222] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:30:0) after 6m45s
[18:58:28.241] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:30:0)
[18:58:28.268] Build status: STARTED
[18:58:28.268] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:31:0) after 2m45s
[19:01:13.285] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:31:0)
[19:01:13.324] Build status: STARTED
[19:01:13.324] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:32:0) after 5m39s
[19:06:52.355] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:32:0)
[19:06:52.399] Build status: STARTED
[19:06:52.399] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:33:0) after 1m17s
[19:08:09.418] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:33:0)
[19:08:09.447] Build status: STARTED
[19:08:09.447] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:34:0) after 5m51s
[19:14:00.468] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:34:0)
[19:14:00.500] Build status: STARTED
[19:14:00.500] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:35:0) after 4m30s
[19:18:30.884] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:35:0)
[19:18:30.910] Build status: STARTED
[19:18:30.910] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:36:0) after 7m27s
[19:25:57.940] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:36:0)
[19:25:57.967] Build status: STARTED
[19:25:57.967] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:37:0) after 6m13s
[19:32:11.103] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:37:0)
[19:32:11.189] Build status: STARTED
[19:32:11.189] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:38:0) after 5m0s
[19:37:11.260] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:38:0)
[19:37:11.285] Build status: STARTED
[19:37:11.285] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:39:0) after 1m40s
[19:38:51.354] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:39:0)
[19:38:51.386] Build status: STARTED
[19:38:51.386] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:40:0) after 9m50s
[19:48:41.408] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:40:0)
[19:48:41.476] Build status: STARTED
[19:48:41.476] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:41:0) after 7m40s
[19:56:21.696] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:41:0)
[19:56:21.732] Build status: STARTED
[19:56:21.732] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:42:0) after 4m56s
[20:01:17.778] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:42:0)
[20:01:17.806] Build status: STARTED
[20:01:17.806] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:43:0) after 2m37s
[20:03:55.015] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:43:0)
[20:03:55.085] Build status: STARTED
[20:03:55.085] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:44:0) after 7m46s
[20:11:41.171] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:44:0)
[20:11:41.212] Build status: STARTED
[20:11:41.212] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:45:0) after 2m13s
[20:13:54.335] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:45:0)
[20:13:54.362] Build status: STARTED
[20:13:54.362] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:46:0) after 2m1s
[20:15:55.444] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:46:0)
[20:15:55.478] Build status: STARTED
[20:15:55.478] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:47:0) after 1m15s
[20:17:10.507] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:47:0)
[20:17:10.532] Build status: STARTED
[20:17:10.532] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:48:0) after 3m53s
[20:21:03.660] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:48:0)
[20:21:03.723] Build status: STARTED
[20:21:03.723] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:49:0) after 1m47s
[20:22:50.718] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:49:0)
[20:22:50.749] Build status: STARTED
[20:22:50.749] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:50:0) after 2m34s
[20:25:24.772] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:50:0)
[20:25:24.804] Build status: STARTED
[20:25:24.804] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:51:0) after 7m52s
[20:33:16.830] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:51:0)
[20:33:16.878] Build status: STARTED
[20:33:16.878] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:52:0) after 6m10s
[20:39:27.041] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:52:0)
[20:39:27.071] Build status: STARTED
[20:39:27.071] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:53:0) after 3m28s
[20:42:55.093] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:53:0)
[20:42:55.122] Build status: STARTED
[20:42:55.122] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:54:0) after 4m18s
[20:47:13.295] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:54:0)
[20:47:13.326] Build status: STARTED
[20:47:13.326] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:55:0) after 1m28s
[20:48:41.547] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:55:0)
[20:48:41.574] Build status: STARTED
[20:48:41.574] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:56:0) after 9m50s
[20:58:31.807] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:56:0)
[20:58:31.842] Build status: STARTED
[20:58:31.842] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:57:0) after 7m34s
[21:06:05.863] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:57:0)
[21:06:05.894] Build status: STARTED
[21:06:05.894] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:58:0) after 6m2s
[21:12:07.917] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:58:0)
[21:12:07.949] Build status: STARTED
[21:12:07.949] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:59:0) after 3m14s
[21:15:21.975] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:59:0)
[21:15:22.007] Build status: STARTED
[21:15:22.007] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:60:0) after 3m1s
[21:18:23.089] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:60:0)
[21:18:23.144] Build status: STARTED
[21:18:23.144] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:61:0) after 8m13s
[21:26:36.178] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:61:0)
[21:26:36.207] Build status: STARTED
[21:26:36.207] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:62:0) after 9m42s
[21:36:18.296] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:62:0)
[21:36:18.328] Build status: STARTED
[21:36:18.328] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:63:0) after 4m28s
[21:40:46.354] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:63:0)
[21:40:46.383] Build status: STARTED
[21:40:46.383] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:64:0) after 6m52s
[21:47:38.409] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:64:0)
[21:47:38.441] Build status: STARTED
[21:47:38.441] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:65:0) after 3m32s
[21:51:10.477] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:65:0)
[21:51:10.516] Build status: STARTED
[21:51:10.516] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:66:0) after 7m55s
[21:59:05.536] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:66:0)
[21:59:05.568] Build status: STARTED
[21:59:05.568] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:67:0) after 4m40s
[22:03:45.607] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:67:0)
[22:03:45.653] Build status: STARTED
[22:03:45.653] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:68:0) after 2m9s
[22:05:54.845] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:68:0)
[22:05:54.876] Build status: STARTED
[22:05:54.876] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:69:0) after 4m51s
[22:10:45.902] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:69:0)
[22:10:45.940] Build status: STARTED
[22:10:45.940] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:70:0) after 6m13s
[22:16:58.965] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:70:0)
[22:16:58.994] Build status: STARTED
[22:16:58.994] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:71:0) after 9m12s
[22:26:11.033] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:71:0)
[22:26:11.063] Build status: STARTED
[22:26:11.063] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:72:0) after 4m28s
[22:30:39.084] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:72:0)
[22:30:39.117] Build status: STARTED
[22:30:39.117] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:73:0) after 6m21s
[22:37:00.154] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:73:0)
[22:37:00.185] Build status: STARTED
[22:37:00.185] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:74:0) after 9m8s
[22:46:08.307] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:74:0)
[22:46:08.337] Build status: STARTED
[22:46:08.337] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:75:0) after 3m19s
[22:49:27.359] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:75:0)
[22:49:27.428] Build status: STARTED
[22:49:27.428] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:76:0) after 4m20s
[22:53:47.661] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:76:0)
[22:53:47.695] Build status: STARTED
[22:53:47.695] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:77:0) after 1m27s
[22:55:14.722] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:77:0)
[22:55:14.751] Build status: STARTED
[22:55:14.751] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:78:0) after 5m25s
[23:00:40.199] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:78:0)
[23:00:40.233] Build status: STARTED
[23:00:40.233] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:79:0) after 2m20s
[23:03:00.717] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:79:0)
[23:03:00.972] Build status: STARTED
[23:03:00.972] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:80:0) after 2m45s
[23:05:46.078] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:80:0)
[23:05:46.109] Build status: STARTED
[23:05:46.109] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:81:0) after 8m6s
[23:13:52.133] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:81:0)
[23:13:52.166] Build status: STARTED
[23:13:52.166] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:82:0) after 2m56s
[23:16:48.384] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:82:0)
[23:16:48.413] Build status: STARTED
[23:16:48.413] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:83:0) after 7m44s
[23:24:32.613] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:83:0)
[23:24:32.643] Build status: STARTED
[23:24:32.643] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:84:0) after 7m51s
[23:32:23.667] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:84:0)
[23:32:23.722] Build status: STARTED
[23:32:23.722] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:85:0) after 2m34s
[23:34:58.651] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:85:0)
[23:34:58.684] Build status: STARTED
[23:34:58.684] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:86:0) after 5m21s
[23:40:19.712] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:86:0)
[23:40:19.738] Build status: STARTED
[23:40:19.738] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:87:0) after 2m48s
[23:43:07.760] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:87:0)
[23:43:07.792] Build status: STARTED
[23:43:07.792] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:88:0) after 6m53s
[23:50:00.810] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:88:0)
[23:50:00.837] Build status: STARTED
[23:50:00.837] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:89:0) after 3m19s
[23:53:20.365] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:89:0)
[23:53:20.393] Build status: STARTED
[23:53:20.393] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:90:0) after 2m6s
[23:55:26.782] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:90:0)
[23:55:26.814] Build status: STARTED
[23:55:26.815] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:91:0) after 6m6s
[00:01:33.040] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:91:0)
[00:01:33.079] Build status: STARTED
[00:01:33.079] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:92:0) after 3m56s
[00:05:29.101] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:92:0)
[00:05:29.130] Build status: STARTED
[00:05:29.130] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:93:0) after 5m31s
[00:11:00.380] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:93:0)
[00:11:00.418] Build status: STARTED
[00:11:00.418] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:94:0) after 7m9s
[00:18:09.445] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:94:0)
[00:18:09.493] Build status: STARTED
[00:18:09.493] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:95:0) after 6m56s
[00:25:05.575] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:95:0)
[00:25:05.611] Build status: STARTED
[00:25:05.611] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:96:0) after 8m4s
[00:33:10.101] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:96:0)
[00:33:10.126] Build status: STARTED
[00:33:10.126] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:97:0) after 7m43s
[00:40:53.492] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:97:0)
[00:40:53.521] Build status: STARTED
[00:40:53.521] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:98:0) after 1m55s
[00:42:49.301] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:98:0)
[00:42:49.345] Build status: STARTED
[00:42:49.345] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:99:0) after 7m24s
[00:50:13.372] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:99:0)
[00:50:13.410] Build status: STARTED
[00:50:13.410] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:100:0) after 3m12s
[00:53:25.555] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:100:0)
[00:53:25.585] Build status: STARTED
[00:53:25.585] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:101:0) after 2m54s
[00:56:19.911] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:101:0)
[00:56:19.938] Build status: STARTED
[00:56:19.938] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:102:0) after 9m23s
[01:05:43.264] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:102:0)
[01:05:43.317] Build status: STARTED
[01:05:43.317] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9002434743266129248:103:0) after 8m12s
[01:10:24.974] Received PubSub notification, asking Buildbucket for the build status
[01:10:25.003] Build:
{
"id": "8837004681236447089",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac (dbg)"
},
"number": 27115,
"createdBy": "project:chromium",
"createTime": "2021-09-04T16:23:43.751305302Z",
"startTime": "2021-09-04T16:23:56.593747Z",
"endTime": "2021-09-05T01:10:24.576796400Z",
"updateTime": "2021-09-05T01:10:24.577305338Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "df6422f22ec542fdf2d19c99ca543a90553969f5",
"ref": "refs/heads/main"
}
}
}
[01:10:25.003] Invocation finished in 8h46m42.571572473s with status FAILED