[02:18:48.074] New invocation is queued and will start shortly
[02:18:49.166] Starting the invocation (attempt 1)
[02:18:49.190] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/8e1c9e983e5e57bddc4e36e8d34d54e47a7f4e86"
[02:18:49.190] Popped gitiles commit info from properties and tags
[02:18:49.190] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:18:49.190] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:18:49.190] Buildbucket request:
{
"requestId": "8857804544821110672",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "fuchsia-coverage"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8857804544821110672",
"job": "fuchsia/global.ci-fuchsia-coverage-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "07f52a2fa21d5496cf6b4fc27c7609ca55be0359"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@07f52a2fa21d5496cf6b4fc27c7609ca55be0359",
"title": "07f52a2fa21d5496cf6b4fc27c7609ca55be0359",
"url": "https://fuchsia.googlesource.com/integration/+/07f52a2fa21d5496cf6b4fc27c7609ca55be0359"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8e1c9e983e5e57bddc4e36e8d34d54e47a7f4e86"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8e1c9e983e5e57bddc4e36e8d34d54e47a7f4e86",
"title": "8e1c9e983e5e57bddc4e36e8d34d54e47a7f4e86",
"url": "https://fuchsia.googlesource.com/integration/+/8e1c9e983e5e57bddc4e36e8d34d54e47a7f4e86"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "8e1c9e983e5e57bddc4e36e8d34d54e47a7f4e86",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8857804544821110672"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/global.ci-fuchsia-coverage-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[02:18:50.322] Scheduled build:
{
"id": "8692374482935305857",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "fuchsia-coverage"
},
"createdBy": "project:fuchsia",
"createTime": "2026-01-18T02:18:49.247750959Z",
"updateTime": "2026-01-18T02:18:49.247750959Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "8e1c9e983e5e57bddc4e36e8d34d54e47a7f4e86",
"ref": "refs/heads/main"
}
}
}
[02:18:50.322] Task URL: https://cr-buildbucket.appspot.com/build/8692374482935305857
[02:18:50.322] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:2:0) after 2m40s
[02:18:50.851] Received PubSub notification, asking Buildbucket for the build status
[02:18:50.902] Build status: SCHEDULED
[02:18:53.651] Received PubSub notification, asking Buildbucket for the build status
[02:18:53.670] Build status: STARTED
[02:21:30.517] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:2:0)
[02:21:30.545] Build status: STARTED
[02:21:30.545] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:5:0) after 4m44s
[02:26:14.560] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:5:0)
[02:26:14.603] Build status: STARTED
[02:26:14.603] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:6:0) after 8m24s
[02:34:38.793] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:6:0)
[02:34:38.828] Build status: STARTED
[02:34:38.828] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:7:0) after 7m13s
[02:41:51.903] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:7:0)
[02:41:51.927] Build status: STARTED
[02:41:51.927] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:8:0) after 6m55s
[02:48:46.939] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:8:0)
[02:48:46.959] Build status: STARTED
[02:48:46.959] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:9:0) after 1m0s
[02:49:47.213] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:9:0)
[02:49:47.280] Build status: STARTED
[02:49:47.280] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:10:0) after 1m21s
[02:51:08.305] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:10:0)
[02:51:08.320] Build status: STARTED
[02:51:08.320] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:11:0) after 4m44s
[02:55:52.291] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:11:0)
[02:55:52.306] Build status: STARTED
[02:55:52.306] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:12:0) after 1m52s
[02:57:44.272] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:12:0)
[02:57:44.289] Build status: STARTED
[02:57:44.289] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:13:0) after 1m11s
[02:58:55.355] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:13:0)
[02:58:55.431] Build status: STARTED
[02:58:55.431] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:14:0) after 4m6s
[03:03:01.639] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:14:0)
[03:03:01.661] Build status: STARTED
[03:03:01.661] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:15:0) after 3m25s
[03:06:26.686] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:15:0)
[03:06:26.706] Build status: STARTED
[03:06:26.706] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:16:0) after 6m12s
[03:12:38.744] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:16:0)
[03:12:38.758] Build status: STARTED
[03:12:38.758] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:17:0) after 5m4s
[03:17:42.769] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:17:0)
[03:17:42.844] Build status: STARTED
[03:17:42.844] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:18:0) after 7m20s
[03:25:02.859] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:18:0)
[03:25:02.894] Build status: STARTED
[03:25:02.894] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:19:0) after 8m39s
[03:33:41.906] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:19:0)
[03:33:41.921] Build status: STARTED
[03:33:41.921] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:20:0) after 3m33s
[03:37:14.932] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:20:0)
[03:37:14.949] Build status: STARTED
[03:37:14.949] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:21:0) after 2m48s
[03:40:03.032] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:21:0)
[03:40:03.050] Build status: STARTED
[03:40:03.051] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:22:0) after 9m38s
[03:49:41.063] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:22:0)
[03:49:41.079] Build status: STARTED
[03:49:41.079] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:23:0) after 1m26s
[03:51:07.096] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:23:0)
[03:51:07.112] Build status: STARTED
[03:51:07.112] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:24:0) after 2m21s
[03:53:28.124] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:24:0)
[03:53:28.138] Build status: STARTED
[03:53:28.138] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:25:0) after 6m5s
[03:59:33.221] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:25:0)
[03:59:33.254] Build status: STARTED
[03:59:33.254] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:26:0) after 7m17s
[04:06:50.302] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:26:0)
[04:06:50.322] Build status: STARTED
[04:06:50.323] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:27:0) after 4m10s
[04:11:00.478] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:27:0)
[04:11:00.492] Build status: STARTED
[04:11:00.492] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:28:0) after 6m37s
[04:17:37.653] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:28:0)
[04:17:37.791] Build status: STARTED
[04:17:37.791] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:29:0) after 8m3s
[04:25:40.867] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:29:0)
[04:25:40.888] Build status: STARTED
[04:25:40.888] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:30:0) after 2m45s
[04:28:25.913] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:30:0)
[04:28:25.927] Build status: STARTED
[04:28:25.927] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:31:0) after 9m54s
[04:38:20.078] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:31:0)
[04:38:20.094] Build status: STARTED
[04:38:20.094] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:32:0) after 4m52s
[04:43:12.112] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:32:0)
[04:43:12.130] Build status: STARTED
[04:43:12.131] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:33:0) after 5m21s
[04:48:33.212] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:33:0)
[04:48:33.228] Build status: STARTED
[04:48:33.228] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:34:0) after 7m56s
[04:56:29.241] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:34:0)
[04:56:29.276] Build status: STARTED
[04:56:29.276] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:35:0) after 5m21s
[05:01:50.887] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:35:0)
[05:01:50.901] Build status: STARTED
[05:01:50.901] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:36:0) after 2m52s
[05:04:42.926] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:36:0)
[05:04:42.947] Build status: STARTED
[05:04:42.948] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:37:0) after 5m59s
[05:10:42.097] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:37:0)
[05:10:42.121] Build status: STARTED
[05:10:42.121] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:38:0) after 8m58s
[05:19:40.229] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:38:0)
[05:19:40.244] Build status: STARTED
[05:19:40.244] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:39:0) after 3m4s
[05:22:44.360] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:39:0)
[05:22:44.378] Build status: STARTED
[05:22:44.378] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:40:0) after 3m15s
[05:25:59.571] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:40:0)
[05:25:59.589] Build status: STARTED
[05:25:59.589] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:41:0) after 7m55s
[05:33:54.648] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:41:0)
[05:33:54.665] Build status: STARTED
[05:33:54.665] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:42:0) after 5m25s
[05:39:19.735] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:42:0)
[05:39:19.969] Build status: STARTED
[05:39:19.969] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:43:0) after 7m52s
[05:47:12.056] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:43:0)
[05:47:12.075] Build status: STARTED
[05:47:12.075] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:44:0) after 1m17s
[05:48:29.179] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:44:0)
[05:48:29.193] Build status: STARTED
[05:48:29.193] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:45:0) after 8m17s
[05:56:46.735] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:45:0)
[05:56:46.751] Build status: STARTED
[05:56:46.751] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:46:0) after 7m19s
[06:04:05.738] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:46:0)
[06:04:05.751] Build status: STARTED
[06:04:05.751] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:47:0) after 3m12s
[06:07:17.768] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:47:0)
[06:07:17.788] Build status: STARTED
[06:07:17.788] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-coverage-e5a0ec7f:8857804544821110672:48:0) after 8m21s
[06:08:44.303] Received PubSub notification, asking Buildbucket for the build status
[06:08:44.318] Build:
{
"id": "8692374482935305857",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "fuchsia-coverage"
},
"createdBy": "project:fuchsia",
"createTime": "2026-01-18T02:18:49.247750959Z",
"startTime": "2026-01-18T02:18:53.456966206Z",
"endTime": "2026-01-18T06:08:43.950166937Z",
"updateTime": "2026-01-18T06:08:43.950166937Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "8e1c9e983e5e57bddc4e36e8d34d54e47a7f4e86",
"ref": "refs/heads/main"
}
}
}
[06:08:44.318] Invocation finished in 3h49m56.252264113s with status SUCCEEDED