[04:00:06.689] New invocation is queued and will start shortly
[04:00:08.136] Starting the invocation (attempt 1)
[04:00:08.179] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/729dc0c0f7c75e8c10d332ee8415810c96964ab8"
[04:00:08.179] Popped gitiles commit info from properties and tags
[04:00:08.179] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:00:08.179] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:00:08.179] Buildbucket request:
{
"requestId": "8933265443958986480",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "linux-chromeos-code-coverage"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "729dc0c0f7c75e8c10d332ee8415810c96964ab8",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8933265443958986480"
},
{
"key": "scheduler_job_id",
"value": "chromium/linux-chromeos-code-coverage"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[04:00:08.773] Scheduled build:
{
"id": "8767835381641951857",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "linux-chromeos-code-coverage"
},
"number": 5493,
"createdBy": "project:chromium",
"createTime": "2023-10-08T04:00:08.258838205Z",
"updateTime": "2023-10-08T04:00:08.258838205Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "729dc0c0f7c75e8c10d332ee8415810c96964ab8",
"ref": "refs/heads/main"
}
}
}
[04:00:08.773] Task URL: https://cr-buildbucket.appspot.com/build/8767835381641951857
[04:00:08.773] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:2:0) after 8m52s
[04:00:09.424] Received PubSub notification, asking Buildbucket for the build status
[04:00:09.452] Build status: SCHEDULED
[04:00:31.935] Received PubSub notification, asking Buildbucket for the build status
[04:00:31.984] Build status: STARTED
[04:09:00.792] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:2:0)
[04:09:00.809] Build status: STARTED
[04:09:00.809] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:5:0) after 6m3s
[04:15:03.846] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:5:0)
[04:15:03.979] Build status: STARTED
[04:15:03.979] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:6:0) after 9m23s
[04:24:27.019] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:6:0)
[04:24:27.053] Build status: STARTED
[04:24:27.053] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:7:0) after 8m11s
[04:32:39.202] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:7:0)
[04:32:39.230] Build status: STARTED
[04:32:39.230] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:8:0) after 5m50s
[04:38:29.863] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:8:0)
[04:38:29.885] Build status: STARTED
[04:38:29.885] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:9:0) after 4m20s
[04:42:49.908] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:9:0)
[04:42:49.923] Build status: STARTED
[04:42:49.923] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:10:0) after 3m39s
[04:46:29.029] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:10:0)
[04:46:29.051] Build status: STARTED
[04:46:29.051] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:11:0) after 1m22s
[04:47:51.215] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:11:0)
[04:47:51.234] Build status: STARTED
[04:47:51.234] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:12:0) after 9m48s
[04:57:39.252] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:12:0)
[04:57:39.271] Build status: STARTED
[04:57:39.271] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:13:0) after 7m57s
[05:05:36.295] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:13:0)
[05:05:36.317] Build status: STARTED
[05:05:36.317] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:14:0) after 1m48s
[05:07:24.435] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:14:0)
[05:07:24.453] Build status: STARTED
[05:07:24.453] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:15:0) after 4m14s
[05:11:38.590] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:15:0)
[05:11:38.813] Build status: STARTED
[05:11:38.813] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:16:0) after 5m28s
[05:17:06.982] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:16:0)
[05:17:07.037] Build status: STARTED
[05:17:07.037] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:17:0) after 7m30s
[05:24:37.066] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:17:0)
[05:24:37.151] Build status: STARTED
[05:24:37.151] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:18:0) after 6m54s
[05:31:31.327] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:18:0)
[05:31:31.345] Build status: STARTED
[05:31:31.345] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:19:0) after 4m21s
[05:35:52.370] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:19:0)
[05:35:52.409] Build status: STARTED
[05:35:52.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:20:0) after 3m8s
[05:39:00.438] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:20:0)
[05:39:00.459] Build status: STARTED
[05:39:00.459] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:21:0) after 6m4s
[05:45:04.492] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:21:0)
[05:45:04.512] Build status: STARTED
[05:45:04.512] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:22:0) after 2m50s
[05:47:54.549] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:22:0)
[05:47:54.573] Build status: STARTED
[05:47:54.573] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:23:0) after 9m4s
[05:56:58.586] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:23:0)
[05:56:58.622] Build status: STARTED
[05:56:58.622] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:24:0) after 4m30s
[06:01:29.125] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:24:0)
[06:01:29.153] Build status: STARTED
[06:01:29.153] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:25:0) after 8m35s
[06:10:05.062] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:25:0)
[06:10:05.091] Build status: STARTED
[06:10:05.091] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:26:0) after 7m3s
[06:17:08.144] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:26:0)
[06:17:08.164] Build status: STARTED
[06:17:08.164] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:27:0) after 8m53s
[06:26:01.187] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:27:0)
[06:26:01.205] Build status: STARTED
[06:26:01.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:28:0) after 8m56s
[06:34:57.240] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:28:0)
[06:34:57.260] Build status: STARTED
[06:34:57.260] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:29:0) after 2m11s
[06:37:08.329] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:29:0)
[06:37:08.348] Build status: STARTED
[06:37:08.348] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:30:0) after 5m15s
[06:42:23.369] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:30:0)
[06:42:23.389] Build status: STARTED
[06:42:23.389] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:31:0) after 1m56s
[06:44:19.435] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:31:0)
[06:44:19.464] Build status: STARTED
[06:44:19.464] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:32:0) after 3m40s
[06:47:59.633] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:32:0)
[06:47:59.655] Build status: STARTED
[06:47:59.655] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:33:0) after 3m56s
[06:51:55.680] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:33:0)
[06:51:55.706] Build status: STARTED
[06:51:55.706] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:34:0) after 9m10s
[07:01:05.700] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:34:0)
[07:01:05.756] Build status: STARTED
[07:01:05.756] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:35:0) after 7m4s
[07:08:09.744] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:35:0)
[07:08:09.824] Build status: STARTED
[07:08:09.824] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:36:0) after 7m49s
[07:15:58.878] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:36:0)
[07:15:58.903] Build status: STARTED
[07:15:58.905] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:37:0) after 9m43s
[07:25:42.047] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:37:0)
[07:25:42.085] Build status: STARTED
[07:25:42.085] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:38:0) after 2m6s
[07:27:48.107] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:38:0)
[07:27:48.125] Build status: STARTED
[07:27:48.125] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:39:0) after 5m4s
[07:32:52.151] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:39:0)
[07:32:52.168] Build status: STARTED
[07:32:52.168] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:40:0) after 9m41s
[07:42:33.191] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:40:0)
[07:42:33.211] Build status: STARTED
[07:42:33.211] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:41:0) after 9m44s
[07:52:17.298] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:41:0)
[07:52:17.503] Build status: STARTED
[07:52:17.503] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:42:0) after 5m53s
[07:58:10.519] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:42:0)
[07:58:10.539] Build status: STARTED
[07:58:10.539] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:43:0) after 3m57s
[08:02:07.558] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:43:0)
[08:02:07.578] Build status: STARTED
[08:02:07.578] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:44:0) after 1m11s
[08:03:18.599] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:44:0)
[08:03:18.630] Build status: STARTED
[08:03:18.630] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:45:0) after 8m58s
[08:12:16.660] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:45:0)
[08:12:16.710] Build status: STARTED
[08:12:16.710] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:46:0) after 9m55s
[08:22:11.727] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:46:0)
[08:22:11.829] Build status: STARTED
[08:22:11.829] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:47:0) after 6m36s
[08:28:47.948] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:47:0)
[08:28:47.997] Build status: STARTED
[08:28:47.997] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:48:0) after 1m49s
[08:30:37.151] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:48:0)
[08:30:37.171] Build status: STARTED
[08:30:37.171] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:49:0) after 9m12s
[08:39:49.250] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:49:0)
[08:39:49.273] Build status: STARTED
[08:39:49.273] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:50:0) after 6m35s
[08:46:24.278] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:50:0)
[08:46:24.355] Build status: STARTED
[08:46:24.355] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:51:0) after 9m18s
[08:55:42.428] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:51:0)
[08:55:42.448] Build status: STARTED
[08:55:42.448] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:52:0) after 2m47s
[08:58:29.726] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:52:0)
[08:58:29.745] Build status: STARTED
[08:58:29.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:53:0) after 1m31s
[09:00:00.753] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:53:0)
[09:00:00.796] Build status: STARTED
[09:00:00.796] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:54:0) after 1m1s
[09:01:01.887] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:54:0)
[09:01:01.909] Build status: STARTED
[09:01:01.910] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:55:0) after 6m21s
[09:07:22.934] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:55:0)
[09:07:22.957] Build status: STARTED
[09:07:22.957] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:56:0) after 2m56s
[09:10:19.016] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:56:0)
[09:10:19.046] Build status: STARTED
[09:10:19.046] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:57:0) after 4m17s
[09:14:36.179] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:57:0)
[09:14:36.215] Build status: STARTED
[09:14:36.215] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:58:0) after 9m59s
[09:24:35.334] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:58:0)
[09:24:35.354] Build status: STARTED
[09:24:35.354] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:59:0) after 7m5s
[09:31:40.375] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:59:0)
[09:31:40.401] Build status: STARTED
[09:31:40.401] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:60:0) after 2m58s
[09:34:38.471] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:60:0)
[09:34:38.489] Build status: STARTED
[09:34:38.489] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:61:0) after 9m24s
[09:44:02.610] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:61:0)
[09:44:02.629] Build status: STARTED
[09:44:02.629] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:62:0) after 8m41s
[09:52:43.643] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:62:0)
[09:52:43.665] Build status: STARTED
[09:52:43.665] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:63:0) after 8m44s
[10:01:27.693] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:63:0)
[10:01:27.717] Build status: STARTED
[10:01:27.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:64:0) after 5m7s
[10:06:34.745] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:64:0)
[10:06:34.860] Build status: STARTED
[10:06:34.860] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:65:0) after 4m48s
[10:11:22.886] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:65:0)
[10:11:22.907] Build status: STARTED
[10:11:22.907] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:66:0) after 5m59s
[10:17:21.926] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:66:0)
[10:17:21.944] Build status: STARTED
[10:17:21.944] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:67:0) after 3m0s
[10:20:21.996] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:67:0)
[10:20:22.030] Build status: STARTED
[10:20:22.030] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:68:0) after 6m9s
[10:26:31.338] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:68:0)
[10:26:31.363] Build status: STARTED
[10:26:31.363] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:69:0) after 4m14s
[10:30:45.615] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:69:0)
[10:30:45.634] Build status: STARTED
[10:30:45.634] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:70:0) after 5m35s
[10:36:20.776] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:70:0)
[10:36:20.854] Build status: STARTED
[10:36:20.854] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:71:0) after 7m5s
[10:43:26.430] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:71:0)
[10:43:26.450] Build status: STARTED
[10:43:26.450] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:72:0) after 1m17s
[10:44:44.136] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:72:0)
[10:44:44.183] Build status: STARTED
[10:44:44.183] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:73:0) after 6m20s
[10:51:04.210] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:73:0)
[10:51:04.227] Build status: STARTED
[10:51:04.227] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:74:0) after 4m55s
[10:55:59.530] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:74:0)
[10:55:59.555] Build status: STARTED
[10:55:59.556] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:75:0) after 4m16s
[11:00:17.761] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:75:0)
[11:00:17.902] Build status: STARTED
[11:00:17.902] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:76:0) after 5m31s
[11:05:49.036] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:76:0)
[11:05:49.078] Build status: STARTED
[11:05:49.078] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:77:0) after 8m36s
[11:14:25.117] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:77:0)
[11:14:25.141] Build status: STARTED
[11:14:25.141] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:78:0) after 6m25s
[11:20:50.281] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:78:0)
[11:20:50.300] Build status: STARTED
[11:20:50.300] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:79:0) after 1m48s
[11:22:38.852] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:79:0)
[11:22:38.872] Build status: STARTED
[11:22:38.872] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:80:0) after 1m50s
[11:24:28.990] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:80:0)
[11:24:29.012] Build status: STARTED
[11:24:29.012] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:81:0) after 5m30s
[11:29:59.039] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:81:0)
[11:29:59.058] Build status: STARTED
[11:29:59.058] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:82:0) after 5m58s
[11:35:57.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:82:0)
[11:35:57.225] Build status: STARTED
[11:35:57.225] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:83:0) after 2m31s
[11:38:28.213] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:83:0)
[11:38:28.233] Build status: STARTED
[11:38:28.233] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:84:0) after 9m19s
[11:47:47.253] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:84:0)
[11:47:47.279] Build status: STARTED
[11:47:47.279] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:85:0) after 6m46s
[11:54:33.299] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:85:0)
[11:54:33.320] Build status: STARTED
[11:54:33.320] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:86:0) after 4m6s
[11:58:39.341] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:86:0)
[11:58:39.360] Build status: STARTED
[11:58:39.360] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:87:0) after 8m16s
[12:06:55.385] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:87:0)
[12:06:55.432] Build status: STARTED
[12:06:55.432] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:88:0) after 1m51s
[12:08:46.458] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:88:0)
[12:08:46.476] Build status: STARTED
[12:08:46.476] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-code-coverage:8933265443958986480:89:0) after 7m32s
[12:15:04.142] Received PubSub notification, asking Buildbucket for the build status
[12:15:04.169] Build:
{
"id": "8767835381641951857",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "linux-chromeos-code-coverage"
},
"number": 5493,
"createdBy": "project:chromium",
"createTime": "2023-10-08T04:00:08.258838205Z",
"startTime": "2023-10-08T04:00:31.443211826Z",
"endTime": "2023-10-08T12:15:03.451466754Z",
"updateTime": "2023-10-08T12:15:03.451466754Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "729dc0c0f7c75e8c10d332ee8415810c96964ab8",
"ref": "refs/heads/main"
}
}
}
[12:15:04.169] Invocation finished in 8h14m57.505849028s with status FAILED