[13:37:32.362] New invocation is queued and will start shortly
[13:37:33.411] Starting the invocation (attempt 1)
[13:37:33.437] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/fuchsia/+/16420f4a991b0187069e0c8cc5084e4cbc8c6a03"
[13:37:33.437] Popped gitiles commit info from properties and tags
[13:37:33.437] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:37:33.437] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:37:33.437] Buildbucket request:
{
"requestId": "8918461809800174304",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "fuchsia-coverage"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8918461809800174304",
"job": "fuchsia/fuchsia-coverage-af244ac6",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "09023a0bba4f5c24f4debe1dc29d4bbd928f21d1"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@09023a0bba4f5c24f4debe1dc29d4bbd928f21d1",
"title": "09023a0bba4f5c24f4debe1dc29d4bbd928f21d1",
"url": "https://fuchsia.googlesource.com/fuchsia/+/09023a0bba4f5c24f4debe1dc29d4bbd928f21d1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "94ca9bcb7ce4dbdb59a0b7da7ad203df22c6fa33"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@94ca9bcb7ce4dbdb59a0b7da7ad203df22c6fa33",
"title": "94ca9bcb7ce4dbdb59a0b7da7ad203df22c6fa33",
"url": "https://fuchsia.googlesource.com/fuchsia/+/94ca9bcb7ce4dbdb59a0b7da7ad203df22c6fa33"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "f4444108f16dbf45d3570de038d81c7362c104f2"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@f4444108f16dbf45d3570de038d81c7362c104f2",
"title": "f4444108f16dbf45d3570de038d81c7362c104f2",
"url": "https://fuchsia.googlesource.com/fuchsia/+/f4444108f16dbf45d3570de038d81c7362c104f2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "dad31a0f1e02c3878b06ad2fbb7da56ad853b940"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@dad31a0f1e02c3878b06ad2fbb7da56ad853b940",
"title": "dad31a0f1e02c3878b06ad2fbb7da56ad853b940",
"url": "https://fuchsia.googlesource.com/fuchsia/+/dad31a0f1e02c3878b06ad2fbb7da56ad853b940"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "53264971c51f371d69af6e1604d17b2ad7a17790"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@53264971c51f371d69af6e1604d17b2ad7a17790",
"title": "53264971c51f371d69af6e1604d17b2ad7a17790",
"url": "https://fuchsia.googlesource.com/fuchsia/+/53264971c51f371d69af6e1604d17b2ad7a17790"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "602568f2b20abac9e2ab2a3020e85dbbe1863bfa"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@602568f2b20abac9e2ab2a3020e85dbbe1863bfa",
"title": "602568f2b20abac9e2ab2a3020e85dbbe1863bfa",
"url": "https://fuchsia.googlesource.com/fuchsia/+/602568f2b20abac9e2ab2a3020e85dbbe1863bfa"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "16420f4a991b0187069e0c8cc5084e4cbc8c6a03"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@16420f4a991b0187069e0c8cc5084e4cbc8c6a03",
"title": "16420f4a991b0187069e0c8cc5084e4cbc8c6a03",
"url": "https://fuchsia.googlesource.com/fuchsia/+/16420f4a991b0187069e0c8cc5084e4cbc8c6a03"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "fuchsia",
"id": "16420f4a991b0187069e0c8cc5084e4cbc8c6a03",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8918461809800174304"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/fuchsia-coverage-af244ac6"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[13:37:33.913] Scheduled build:
{
"id": "8753031747954339985",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "fuchsia-coverage"
},
"createdBy": "project:fuchsia",
"createTime": "2024-03-19T13:37:33.495703979Z",
"updateTime": "2024-03-19T13:37:33.495703979Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "fuchsia",
"id": "16420f4a991b0187069e0c8cc5084e4cbc8c6a03",
"ref": "refs/heads/main"
}
}
}
[13:37:33.913] Task URL: https://cr-buildbucket.appspot.com/build/8753031747954339985
[13:37:33.913] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:2:0) after 1m56s
[13:37:34.183] Received PubSub notification, asking Buildbucket for the build status
[13:37:34.330] Build status: SCHEDULED
[13:37:35.212] Received PubSub notification, asking Buildbucket for the build status
[13:37:35.239] Build status: STARTED
[13:39:30.233] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:2:0)
[13:39:30.251] Build status: STARTED
[13:39:30.251] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:5:0) after 8m0s
[13:47:30.270] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:5:0)
[13:47:30.315] Build status: STARTED
[13:47:30.315] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:6:0) after 6m12s
[13:53:42.359] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:6:0)
[13:53:42.397] Build status: STARTED
[13:53:42.397] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:7:0) after 2m25s
[13:56:07.434] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:7:0)
[13:56:07.454] Build status: STARTED
[13:56:07.454] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:8:0) after 1m21s
[13:57:28.520] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:8:0)
[13:57:28.657] Build status: STARTED
[13:57:28.657] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:9:0) after 8m5s
[14:05:33.711] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:9:0)
[14:05:33.743] Build status: STARTED
[14:05:33.743] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:10:0) after 3m36s
[14:09:09.915] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:10:0)
[14:09:10.070] Build status: STARTED
[14:09:10.070] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:11:0) after 1m14s
[14:10:24.090] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:11:0)
[14:10:24.132] Build status: STARTED
[14:10:24.132] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:12:0) after 2m36s
[14:13:00.150] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:12:0)
[14:13:00.169] Build status: STARTED
[14:13:00.169] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:13:0) after 8m28s
[14:21:28.526] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:13:0)
[14:21:28.577] Build status: STARTED
[14:21:28.577] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:14:0) after 9m1s
[14:30:29.688] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:14:0)
[14:30:29.787] Build status: STARTED
[14:30:29.787] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:15:0) after 5m30s
[14:35:59.805] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:15:0)
[14:35:59.826] Build status: STARTED
[14:35:59.826] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:16:0) after 7m24s
[14:43:23.926] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:16:0)
[14:43:23.947] Build status: STARTED
[14:43:23.947] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:17:0) after 3m42s
[14:47:05.995] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:17:0)
[14:47:06.038] Build status: STARTED
[14:47:06.038] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:18:0) after 8m33s
[14:55:39.060] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:18:0)
[14:55:39.078] Build status: STARTED
[14:55:39.078] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:19:0) after 7m13s
[15:02:52.132] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:19:0)
[15:02:52.169] Build status: STARTED
[15:02:52.169] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:20:0) after 8m36s
[15:11:28.175] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:20:0)
[15:11:28.200] Build status: STARTED
[15:11:28.200] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:21:0) after 5m40s
[15:17:08.296] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:21:0)
[15:17:08.467] Build status: STARTED
[15:17:08.467] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:22:0) after 1m22s
[15:18:30.493] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:22:0)
[15:18:30.522] Build status: STARTED
[15:18:30.522] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:23:0) after 4m45s
[15:23:15.628] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:23:0)
[15:23:15.651] Build status: STARTED
[15:23:15.651] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:24:0) after 2m55s
[15:26:10.680] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:24:0)
[15:26:10.705] Build status: STARTED
[15:26:10.705] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:25:0) after 3m59s
[15:30:09.939] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:25:0)
[15:30:09.967] Build status: STARTED
[15:30:09.967] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:26:0) after 4m38s
[15:34:48.089] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:26:0)
[15:34:48.222] Build status: STARTED
[15:34:48.223] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:27:0) after 8m52s
[15:43:40.251] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:27:0)
[15:43:40.291] Build status: STARTED
[15:43:40.291] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:28:0) after 4m6s
[15:47:46.372] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:28:0)
[15:47:46.426] Build status: STARTED
[15:47:46.426] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:29:0) after 3m8s
[15:50:54.520] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:29:0)
[15:50:54.549] Build status: STARTED
[15:50:54.549] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:30:0) after 8m38s
[15:59:32.584] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:30:0)
[15:59:32.604] Build status: STARTED
[15:59:32.604] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:31:0) after 3m4s
[16:02:36.671] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:31:0)
[16:02:36.735] Build status: STARTED
[16:02:36.735] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:32:0) after 9m34s
[16:12:10.785] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:32:0)
[16:12:10.843] Build status: STARTED
[16:12:10.843] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:33:0) after 3m28s
[16:15:39.018] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:33:0)
[16:15:39.074] Build status: STARTED
[16:15:39.074] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:34:0) after 6m28s
[16:22:07.107] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:34:0)
[16:22:07.137] Build status: STARTED
[16:22:07.137] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:35:0) after 3m9s
[16:25:16.222] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:35:0)
[16:25:16.267] Build status: STARTED
[16:25:16.268] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:36:0) after 5m27s
[16:30:43.345] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:36:0)
[16:30:43.365] Build status: STARTED
[16:30:43.365] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:37:0) after 4m2s
[16:34:45.428] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:37:0)
[16:34:45.449] Build status: STARTED
[16:34:45.449] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:38:0) after 1m45s
[16:36:30.488] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:38:0)
[16:36:30.563] Build status: STARTED
[16:36:30.563] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:39:0) after 5m52s
[16:42:22.674] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:39:0)
[16:42:22.698] Build status: STARTED
[16:42:22.698] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:40:0) after 2m24s
[16:44:46.939] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:40:0)
[16:44:46.962] Build status: STARTED
[16:44:46.962] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:41:0) after 3m2s
[16:47:49.700] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:41:0)
[16:47:49.730] Build status: STARTED
[16:47:49.730] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:42:0) after 1m24s
[16:49:13.894] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:42:0)
[16:49:13.916] Build status: STARTED
[16:49:13.916] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:43:0) after 6m36s
[16:55:49.950] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:43:0)
[16:55:49.992] Build status: STARTED
[16:55:49.994] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:44:0) after 4m29s
[17:00:19.031] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:44:0)
[17:00:19.062] Build status: STARTED
[17:00:19.062] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:45:0) after 1m46s
[17:02:05.345] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:45:0)
[17:02:05.418] Build status: STARTED
[17:02:05.418] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:46:0) after 6m59s
[17:09:04.593] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:46:0)
[17:09:04.715] Build status: STARTED
[17:09:04.715] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:47:0) after 2m9s
[17:11:13.797] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:47:0)
[17:11:13.832] Build status: STARTED
[17:11:13.832] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:48:0) after 3m16s
[17:14:29.876] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:48:0)
[17:14:29.902] Build status: STARTED
[17:14:29.902] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:49:0) after 3m4s
[17:17:33.921] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:49:0)
[17:17:33.953] Build status: STARTED
[17:17:33.953] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:50:0) after 4m40s
[17:22:13.953] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:50:0)
[17:22:13.979] Build status: STARTED
[17:22:13.979] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:51:0) after 1m59s
[17:24:13.001] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:51:0)
[17:24:13.040] Build status: STARTED
[17:24:13.041] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:52:0) after 8m4s
[17:32:17.086] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:52:0)
[17:32:17.221] Build status: STARTED
[17:32:17.221] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:53:0) after 1m9s
[17:33:26.466] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:53:0)
[17:33:26.517] Build status: STARTED
[17:33:26.517] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:54:0) after 1m15s
[17:34:41.529] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:54:0)
[17:34:41.550] Build status: STARTED
[17:34:41.550] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:55:0) after 2m21s
[17:37:02.630] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:55:0)
[17:37:02.651] Build status: STARTED
[17:37:02.651] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:56:0) after 7m45s
[17:44:47.770] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:56:0)
[17:44:47.841] Build status: STARTED
[17:44:47.841] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:57:0) after 6m53s
[17:51:40.866] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:57:0)
[17:51:40.888] Build status: STARTED
[17:51:40.889] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:58:0) after 9m0s
[18:00:40.910] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:58:0)
[18:00:40.979] Build status: STARTED
[18:00:40.979] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:59:0) after 3m30s
[18:04:11.097] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:59:0)
[18:04:11.238] Build status: STARTED
[18:04:11.238] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:60:0) after 5m32s
[18:09:43.359] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:60:0)
[18:09:43.410] Build status: STARTED
[18:09:43.410] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:61:0) after 3m25s
[18:13:08.432] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:61:0)
[18:13:08.528] Build status: STARTED
[18:13:08.529] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:62:0) after 4m23s
[18:17:31.553] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:62:0)
[18:17:31.775] Build status: STARTED
[18:17:31.775] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:63:0) after 5m18s
[18:22:49.793] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:63:0)
[18:22:49.818] Build status: STARTED
[18:22:49.818] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:64:0) after 7m36s
[18:30:25.844] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:64:0)
[18:30:25.914] Build status: STARTED
[18:30:25.914] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:65:0) after 4m0s
[18:34:25.935] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:65:0)
[18:34:25.991] Build status: STARTED
[18:34:25.991] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:66:0) after 5m2s
[18:39:28.093] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:66:0)
[18:39:28.164] Build status: STARTED
[18:39:28.164] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:67:0) after 5m23s
[18:44:51.186] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:67:0)
[18:44:51.210] Build status: STARTED
[18:44:51.210] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:68:0) after 2m38s
[18:47:29.215] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:68:0)
[18:47:29.235] Build status: STARTED
[18:47:29.236] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:69:0) after 7m4s
[18:54:33.321] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:69:0)
[18:54:33.344] Build status: STARTED
[18:54:33.344] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:70:0) after 9m5s
[19:03:38.424] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:70:0)
[19:03:38.569] Build status: STARTED
[19:03:38.569] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:71:0) after 8m5s
[19:11:43.692] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:71:0)
[19:11:43.711] Build status: STARTED
[19:11:43.711] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:72:0) after 3m1s
[19:14:44.718] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:72:0)
[19:14:44.749] Build status: STARTED
[19:14:44.749] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:73:0) after 9m53s
[19:24:37.769] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:73:0)
[19:24:37.793] Build status: STARTED
[19:24:37.793] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:74:0) after 6m55s
[19:31:32.849] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:74:0)
[19:31:32.871] Build status: STARTED
[19:31:32.871] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:75:0) after 8m37s
[19:40:09.907] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:75:0)
[19:40:09.950] Build status: STARTED
[19:40:09.950] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:76:0) after 3m32s
[19:43:42.028] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:76:0)
[19:43:42.104] Build status: STARTED
[19:43:42.104] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:77:0) after 9m15s
[19:52:57.123] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:77:0)
[19:52:57.151] Build status: STARTED
[19:52:57.151] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:78:0) after 5m14s
[19:58:11.221] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:78:0)
[19:58:11.246] Build status: STARTED
[19:58:11.246] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:79:0) after 6m53s
[20:05:04.249] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:79:0)
[20:05:04.280] Build status: STARTED
[20:05:04.280] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:80:0) after 8m41s
[20:13:45.299] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:80:0)
[20:13:45.437] Build status: STARTED
[20:13:45.437] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:81:0) after 3m41s
[20:17:26.479] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:81:0)
[20:17:26.531] Build status: STARTED
[20:17:26.531] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:82:0) after 9m25s
[20:26:51.583] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:82:0)
[20:26:51.603] Build status: STARTED
[20:26:51.604] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:83:0) after 4m16s
[20:31:07.625] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:83:0)
[20:31:07.648] Build status: STARTED
[20:31:07.648] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:84:0) after 3m32s
[20:34:39.726] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:84:0)
[20:34:39.770] Build status: STARTED
[20:34:39.770] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:85:0) after 1m18s
[20:35:57.817] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:85:0)
[20:35:57.842] Build status: STARTED
[20:35:57.842] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:86:0) after 1m51s
[20:37:48.860] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:86:0)
[20:37:49.013] Build status: STARTED
[20:37:49.013] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:87:0) after 8m56s
[20:46:45.039] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:87:0)
[20:46:45.067] Build status: STARTED
[20:46:45.067] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:88:0) after 5m45s
[20:52:30.140] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:88:0)
[20:52:30.172] Build status: STARTED
[20:52:30.172] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:89:0) after 9m46s
[21:02:16.198] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:89:0)
[21:02:16.244] Build status: STARTED
[21:02:16.244] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:90:0) after 5m17s
[21:07:33.297] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:90:0)
[21:07:33.321] Build status: STARTED
[21:07:33.321] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:91:0) after 2m27s
[21:10:00.425] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:91:0)
[21:10:00.452] Build status: STARTED
[21:10:00.452] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:92:0) after 1m25s
[21:11:25.481] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:92:0)
[21:11:25.502] Build status: STARTED
[21:11:25.502] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:93:0) after 8m28s
[21:19:53.519] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:93:0)
[21:19:53.540] Build status: STARTED
[21:19:53.541] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:94:0) after 8m58s
[21:28:51.569] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:94:0)
[21:28:51.626] Build status: STARTED
[21:28:51.626] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:95:0) after 8m30s
[21:37:21.598] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:95:0)
[21:37:21.671] Build status: STARTED
[21:37:21.671] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8918461809800174304:96:0) after 5m26s
[21:38:05.440] Received PubSub notification, asking Buildbucket for the build status
[21:38:05.468] Build:
{
"id": "8753031747954339985",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "fuchsia-coverage"
},
"createdBy": "project:fuchsia",
"createTime": "2024-03-19T13:37:33.495703979Z",
"startTime": "2024-03-19T13:37:34.393734Z",
"endTime": "2024-03-19T21:38:04.291380Z",
"updateTime": "2024-03-19T21:38:04.291380Z",
"status": "INFRA_FAILURE",
"statusDetails": {
"timeout": {
}
},
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "fuchsia",
"id": "16420f4a991b0187069e0c8cc5084e4cbc8c6a03",
"ref": "refs/heads/main"
}
}
}
[21:38:05.468] Invocation finished in 8h0m33.11725728s with status FAILED