[04:11:09.730] New invocation is queued and will start shortly
[04:11:10.908] Starting the invocation (attempt 1)
[04:11:10.941] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/93551c07db440632421084d42c49cfddcaef2d75"
[04:11:10.941] Popped gitiles commit info from properties and tags
[04:11:10.941] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:11:10.941] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:11:10.941] Buildbucket request:
{
"requestId": "8901284019556761552",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8901284019556761552",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "93551c07db440632421084d42c49cfddcaef2d75"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@93551c07db440632421084d42c49cfddcaef2d75",
"title": "93551c07db440632421084d42c49cfddcaef2d75",
"url": "https://fuchsia.googlesource.com/integration/+/93551c07db440632421084d42c49cfddcaef2d75"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "93551c07db440632421084d42c49cfddcaef2d75",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8901284019556761552"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/firebase-docs-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[04:11:11.526] Scheduled build:
{
"id": "8735853957565711729",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2024-09-25T04:11:11.001712533Z",
"updateTime": "2024-09-25T04:11:11.001712533Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "93551c07db440632421084d42c49cfddcaef2d75",
"ref": "refs/heads/main"
}
}
}
[04:11:11.526] Task URL: https://cr-buildbucket.appspot.com/build/8735853957565711729
[04:11:11.526] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:2:0) after 3m4s
[04:11:12.323] Received PubSub notification, asking Buildbucket for the build status
[04:11:12.345] Build status: SCHEDULED
[04:11:16.325] Received PubSub notification, asking Buildbucket for the build status
[04:11:16.346] Build status: STARTED
[04:14:15.830] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:2:0)
[04:14:15.929] Build status: STARTED
[04:14:15.929] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:5:0) after 2m16s
[04:16:31.944] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:5:0)
[04:16:32.030] Build status: STARTED
[04:16:32.030] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:6:0) after 5m51s
[04:22:23.227] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:6:0)
[04:22:23.327] Build status: STARTED
[04:22:23.327] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:7:0) after 3m49s
[04:26:12.486] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:7:0)
[04:26:12.503] Build status: STARTED
[04:26:12.503] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:8:0) after 4m32s
[04:30:44.520] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:8:0)
[04:30:44.540] Build status: STARTED
[04:30:44.540] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:9:0) after 1m47s
[04:32:31.910] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:9:0)
[04:32:31.940] Build status: STARTED
[04:32:31.940] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:10:0) after 1m3s
[04:33:35.028] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:10:0)
[04:33:35.047] Build status: STARTED
[04:33:35.047] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:11:0) after 5m11s
[04:38:46.148] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:11:0)
[04:38:46.174] Build status: STARTED
[04:38:46.174] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:12:0) after 6m55s
[04:46:11.102] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:12:0)
[04:46:11.123] Build status: STARTED
[04:46:11.123] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:13:0) after 5m7s
[04:51:18.188] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:13:0)
[04:51:18.223] Build status: STARTED
[04:51:18.223] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:14:0) after 1m19s
[04:52:37.407] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:14:0)
[04:52:37.430] Build status: STARTED
[04:52:37.430] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:15:0) after 2m55s
[04:55:32.547] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:15:0)
[04:55:32.608] Build status: STARTED
[04:55:32.608] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:16:0) after 3m39s
[04:59:11.683] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:16:0)
[04:59:11.703] Build status: STARTED
[04:59:11.703] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:17:0) after 5m33s
[05:04:44.887] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:17:0)
[05:04:44.906] Build status: STARTED
[05:04:44.906] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:18:0) after 5m20s
[05:10:05.559] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:18:0)
[05:10:05.625] Build status: STARTED
[05:10:05.625] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:19:0) after 3m45s
[05:13:50.658] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:19:0)
[05:13:50.679] Build status: STARTED
[05:13:50.679] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:20:0) after 3m48s
[05:17:39.030] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:20:0)
[05:17:39.052] Build status: STARTED
[05:17:39.052] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:21:0) after 1m26s
[05:19:05.198] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:21:0)
[05:19:05.240] Build status: STARTED
[05:19:05.240] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:22:0) after 3m59s
[05:23:04.259] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:22:0)
[05:23:04.276] Build status: STARTED
[05:23:04.276] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:23:0) after 9m9s
[05:32:13.363] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:23:0)
[05:32:13.384] Build status: STARTED
[05:32:13.384] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:24:0) after 1m51s
[05:34:04.508] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:24:0)
[05:34:04.524] Build status: STARTED
[05:34:04.524] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:25:0) after 5m33s
[05:39:37.539] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:25:0)
[05:39:37.556] Build status: STARTED
[05:39:37.556] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:26:0) after 1m38s
[05:41:15.575] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:26:0)
[05:41:15.591] Build status: STARTED
[05:41:15.591] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:27:0) after 8m40s
[05:49:55.692] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:27:0)
[05:49:55.708] Build status: STARTED
[05:49:55.708] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:28:0) after 7m34s
[05:57:29.910] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:28:0)
[05:57:29.929] Build status: STARTED
[05:57:29.929] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:29:0) after 3m33s
[06:01:02.945] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:29:0)
[06:01:02.970] Build status: STARTED
[06:01:02.970] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:30:0) after 1m14s
[06:02:17.009] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:30:0)
[06:02:17.032] Build status: STARTED
[06:02:17.032] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:31:0) after 7m41s
[06:09:58.156] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:31:0)
[06:09:58.176] Build status: STARTED
[06:09:58.176] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:32:0) after 4m0s
[06:13:58.181] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:32:0)
[06:13:58.300] Build status: STARTED
[06:13:58.300] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:33:0) after 1m35s
[06:15:33.296] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:33:0)
[06:15:33.327] Build status: STARTED
[06:15:33.327] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:34:0) after 5m12s
[06:20:45.347] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:34:0)
[06:20:45.367] Build status: STARTED
[06:20:45.367] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:35:0) after 3m3s
[06:23:48.483] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:35:0)
[06:23:48.525] Build status: STARTED
[06:23:48.525] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:36:0) after 5m3s
[06:28:51.549] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:36:0)
[06:28:51.565] Build status: STARTED
[06:28:51.565] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:37:0) after 7m35s
[06:36:26.855] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:37:0)
[06:36:26.940] Build status: STARTED
[06:36:26.940] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:38:0) after 7m55s
[06:44:21.984] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:38:0)
[06:44:22.005] Build status: STARTED
[06:44:22.005] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:39:0) after 5m1s
[06:49:23.055] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:39:0)
[06:49:23.140] Build status: STARTED
[06:49:23.140] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:40:0) after 8m19s
[06:57:42.374] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:40:0)
[06:57:42.389] Build status: STARTED
[06:57:42.389] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:41:0) after 1m15s
[06:58:57.533] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:41:0)
[06:58:57.606] Build status: STARTED
[06:58:57.606] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:42:0) after 2m57s
[07:01:54.622] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:42:0)
[07:01:54.655] Build status: STARTED
[07:01:54.655] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:43:0) after 2m22s
[07:04:17.208] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:43:0)
[07:04:17.244] Build status: STARTED
[07:04:17.244] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:44:0) after 1m38s
[07:05:55.367] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:44:0)
[07:05:55.406] Build status: STARTED
[07:05:55.406] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:45:0) after 2m48s
[07:08:43.437] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8901284019556761552:45:0)
[07:08:43.478] Build:
{
"id": "8735853957565711729",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2024-09-25T04:11:11.001712533Z",
"startTime": "2024-09-25T04:11:16.110798442Z",
"endTime": "2024-09-25T07:08:41.801907961Z",
"updateTime": "2024-09-25T07:08:41.801907961Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "93551c07db440632421084d42c49cfddcaef2d75",
"ref": "refs/heads/main"
}
}
}
[07:08:43.478] Invocation finished in 2h57m33.758825672s with status SUCCEEDED