[06:03:22.391] New invocation is queued and will start shortly
[06:03:23.499] Starting the invocation (attempt 1)
[06:03:23.531] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/94771e9ef16f215a0e34b5c5fd8176bcf4c3ee69"
[06:03:23.531] Popped gitiles commit info from properties and tags
[06:03:23.531] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:03:23.531] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:03:23.531] Buildbucket request:
{
"requestId": "8960799166770903680",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8960799166770903680",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "17aa8b0c052f93c953584aa0019ff62cf2b6df23"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@17aa8b0c052f93c953584aa0019ff62cf2b6df23",
"title": "17aa8b0c052f93c953584aa0019ff62cf2b6df23",
"url": "https://fuchsia.googlesource.com/integration/+/17aa8b0c052f93c953584aa0019ff62cf2b6df23"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0b8a38e563bc3beb4738cb264faa21a92e345b9e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0b8a38e563bc3beb4738cb264faa21a92e345b9e",
"title": "0b8a38e563bc3beb4738cb264faa21a92e345b9e",
"url": "https://fuchsia.googlesource.com/integration/+/0b8a38e563bc3beb4738cb264faa21a92e345b9e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0b695dcf738242d0a55cab1bcd59b11c0cfd3343"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0b695dcf738242d0a55cab1bcd59b11c0cfd3343",
"title": "0b695dcf738242d0a55cab1bcd59b11c0cfd3343",
"url": "https://fuchsia.googlesource.com/integration/+/0b695dcf738242d0a55cab1bcd59b11c0cfd3343"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "caa256ca451703197533dba90cf828bdeada5198"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@caa256ca451703197533dba90cf828bdeada5198",
"title": "caa256ca451703197533dba90cf828bdeada5198",
"url": "https://fuchsia.googlesource.com/integration/+/caa256ca451703197533dba90cf828bdeada5198"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ad48aadb4eaaecad0d786d16e4043a0932ef55f8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ad48aadb4eaaecad0d786d16e4043a0932ef55f8",
"title": "ad48aadb4eaaecad0d786d16e4043a0932ef55f8",
"url": "https://fuchsia.googlesource.com/integration/+/ad48aadb4eaaecad0d786d16e4043a0932ef55f8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f9bb8b6e1c8fc597ca9e08969eca408264a98002"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f9bb8b6e1c8fc597ca9e08969eca408264a98002",
"title": "f9bb8b6e1c8fc597ca9e08969eca408264a98002",
"url": "https://fuchsia.googlesource.com/integration/+/f9bb8b6e1c8fc597ca9e08969eca408264a98002"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "94771e9ef16f215a0e34b5c5fd8176bcf4c3ee69"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@94771e9ef16f215a0e34b5c5fd8176bcf4c3ee69",
"title": "94771e9ef16f215a0e34b5c5fd8176bcf4c3ee69",
"url": "https://fuchsia.googlesource.com/integration/+/94771e9ef16f215a0e34b5c5fd8176bcf4c3ee69"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "94771e9ef16f215a0e34b5c5fd8176bcf4c3ee69",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8960799166770903680"
},
{
"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"
}
}
[06:03:23.863] Scheduled build:
{
"id": "8795369104839424961",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2022-12-08T06:03:23.609883867Z",
"updateTime": "2022-12-08T06:03:23.609883867Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "94771e9ef16f215a0e34b5c5fd8176bcf4c3ee69",
"ref": "refs/heads/main"
}
}
}
[06:03:23.863] Task URL: https://cr-buildbucket.appspot.com/build/8795369104839424961
[06:03:23.863] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:2:0) after 8m24s
[06:06:33.335] Received PubSub notification, asking Buildbucket for the build status
[06:06:33.362] Build status: STARTED
[06:11:47.928] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:2:0)
[06:11:48.029] Build status: STARTED
[06:11:48.029] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:4:0) after 8m28s
[06:20:16.046] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:4:0)
[06:20:16.069] Build status: STARTED
[06:20:16.070] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:5:0) after 1m27s
[06:21:43.036] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:5:0)
[06:21:43.066] Build status: STARTED
[06:21:43.066] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:6:0) after 6m5s
[06:27:48.087] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:6:0)
[06:27:48.114] Build status: STARTED
[06:27:48.114] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:7:0) after 5m32s
[06:33:20.136] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:7:0)
[06:33:20.162] Build status: STARTED
[06:33:20.162] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:8:0) after 3m13s
[06:36:33.233] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:8:0)
[06:36:33.266] Build status: STARTED
[06:36:33.266] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:9:0) after 3m21s
[06:39:54.245] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:9:0)
[06:39:54.270] Build status: STARTED
[06:39:54.270] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:10:0) after 5m53s
[06:45:47.580] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:10:0)
[06:45:47.754] Build status: STARTED
[06:45:47.754] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:11:0) after 1m13s
[06:47:00.779] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:11:0)
[06:47:00.811] Build status: STARTED
[06:47:00.811] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:12:0) after 3m15s
[06:50:15.841] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:12:0)
[06:50:15.921] Build status: STARTED
[06:50:15.921] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:13:0) after 4m15s
[06:54:30.975] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:13:0)
[06:54:31.007] Build status: STARTED
[06:54:31.007] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:14:0) after 6m21s
[07:00:52.101] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:14:0)
[07:00:52.125] Build status: STARTED
[07:00:52.125] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:15:0) after 6m48s
[07:07:40.123] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:15:0)
[07:07:40.167] Build status: STARTED
[07:07:40.167] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:16:0) after 6m30s
[07:14:10.341] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:16:0)
[07:14:10.366] Build status: STARTED
[07:14:10.366] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:17:0) after 2m25s
[07:16:35.585] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:17:0)
[07:16:35.611] Build status: STARTED
[07:16:35.611] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:18:0) after 6m9s
[07:22:44.724] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:18:0)
[07:22:44.756] Build status: STARTED
[07:22:44.756] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:19:0) after 7m49s
[07:30:33.775] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:19:0)
[07:30:33.797] Build status: STARTED
[07:30:33.797] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:20:0) after 9m50s
[07:40:23.951] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:20:0)
[07:40:23.977] Build status: STARTED
[07:40:23.977] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:21:0) after 9m15s
[07:49:39.083] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:21:0)
[07:49:39.111] Build status: STARTED
[07:49:39.111] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:22:0) after 1m32s
[07:51:11.161] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:22:0)
[07:51:11.186] Build status: STARTED
[07:51:11.186] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:23:0) after 1m12s
[07:52:23.219] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:23:0)
[07:52:23.244] Build status: STARTED
[07:52:23.244] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:24:0) after 5m30s
[07:57:53.267] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:24:0)
[07:57:53.308] Build status: STARTED
[07:57:53.308] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:25:0) after 4m25s
[08:02:18.384] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:25:0)
[08:02:18.443] Build status: STARTED
[08:02:18.443] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:26:0) after 3m40s
[08:05:58.594] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:26:0)
[08:05:58.630] Build status: STARTED
[08:05:58.630] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:27:0) after 4m4s
[08:10:02.842] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:27:0)
[08:10:02.889] Build status: STARTED
[08:10:02.890] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:28:0) after 9m36s
[08:19:38.910] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:28:0)
[08:19:38.933] Build status: STARTED
[08:19:38.933] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:29:0) after 8m15s
[08:27:53.918] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:29:0)
[08:27:53.942] Build status: STARTED
[08:27:53.942] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:30:0) after 6m38s
[08:34:32.495] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:30:0)
[08:34:32.518] Build status: STARTED
[08:34:32.518] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:31:0) after 7m6s
[08:41:38.594] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:31:0)
[08:41:38.677] Build status: STARTED
[08:41:38.677] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:32:0) after 7m13s
[08:48:51.705] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:32:0)
[08:48:51.775] Build status: STARTED
[08:48:51.775] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:33:0) after 9m14s
[08:58:05.758] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:33:0)
[08:58:05.866] Build status: STARTED
[08:58:05.866] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:34:0) after 1m58s
[09:00:03.895] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:34:0)
[09:00:03.929] Build status: STARTED
[09:00:03.929] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8960799166770903680:35:0) after 9m20s
[09:05:41.995] Received PubSub notification, asking Buildbucket for the build status
[09:05:42.021] Build:
{
"id": "8795369104839424961",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2022-12-08T06:03:23.609883867Z",
"startTime": "2022-12-08T06:06:32.072752Z",
"endTime": "2022-12-08T09:05:41.733558557Z",
"updateTime": "2022-12-08T09:05:41.733558557Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "94771e9ef16f215a0e34b5c5fd8176bcf4c3ee69",
"ref": "refs/heads/main"
}
}
}
[09:05:42.021] Invocation finished in 3h2m19.637971273s with status SUCCEEDED