[19:14:54.811] New invocation is queued and will start shortly
[19:14:56.183] Starting the invocation (attempt 1)
[19:14:56.221] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/ef6a2c5c660caa4034ef97119f6d1891f006fc7a"
[19:14:56.221] Popped gitiles commit info from properties and tags
[19:14:56.221] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:14:56.222] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:14:56.222] Buildbucket request:
{
"requestId": "8950149522292191904",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8950149522292191904",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ca5760f29f9b2282cca164fe4ad819b55e3c3b6d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ca5760f29f9b2282cca164fe4ad819b55e3c3b6d",
"title": "ca5760f29f9b2282cca164fe4ad819b55e3c3b6d",
"url": "https://fuchsia.googlesource.com/integration/+/ca5760f29f9b2282cca164fe4ad819b55e3c3b6d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a406b542f488c218eeb4389ba07e59d05da82247"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a406b542f488c218eeb4389ba07e59d05da82247",
"title": "a406b542f488c218eeb4389ba07e59d05da82247",
"url": "https://fuchsia.googlesource.com/integration/+/a406b542f488c218eeb4389ba07e59d05da82247"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ca3c6d629db4c04451cdc3425560c88cbf03f1ca"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ca3c6d629db4c04451cdc3425560c88cbf03f1ca",
"title": "ca3c6d629db4c04451cdc3425560c88cbf03f1ca",
"url": "https://fuchsia.googlesource.com/integration/+/ca3c6d629db4c04451cdc3425560c88cbf03f1ca"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2a2047404662a2549df0579594c7f20409e3d02d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2a2047404662a2549df0579594c7f20409e3d02d",
"title": "2a2047404662a2549df0579594c7f20409e3d02d",
"url": "https://fuchsia.googlesource.com/integration/+/2a2047404662a2549df0579594c7f20409e3d02d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7ea8966b0c8aa91cf5857f965a34a10ebe965576"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7ea8966b0c8aa91cf5857f965a34a10ebe965576",
"title": "7ea8966b0c8aa91cf5857f965a34a10ebe965576",
"url": "https://fuchsia.googlesource.com/integration/+/7ea8966b0c8aa91cf5857f965a34a10ebe965576"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "78f8bab4b03de7373f34ef891879518b8c0c6959"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@78f8bab4b03de7373f34ef891879518b8c0c6959",
"title": "78f8bab4b03de7373f34ef891879518b8c0c6959",
"url": "https://fuchsia.googlesource.com/integration/+/78f8bab4b03de7373f34ef891879518b8c0c6959"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ef6a2c5c660caa4034ef97119f6d1891f006fc7a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ef6a2c5c660caa4034ef97119f6d1891f006fc7a",
"title": "ef6a2c5c660caa4034ef97119f6d1891f006fc7a",
"url": "https://fuchsia.googlesource.com/integration/+/ef6a2c5c660caa4034ef97119f6d1891f006fc7a"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "ef6a2c5c660caa4034ef97119f6d1891f006fc7a",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8950149522292191904"
},
{
"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"
}
}
[19:14:56.664] Scheduled build:
{
"id": "8784719460038849937",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-04-04T19:14:56.334024967Z",
"updateTime": "2023-04-04T19:14:56.334024967Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "ef6a2c5c660caa4034ef97119f6d1891f006fc7a",
"ref": "refs/heads/main"
}
}
}
[19:14:56.664] Task URL: https://cr-buildbucket.appspot.com/build/8784719460038849937
[19:14:56.664] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:2:0) after 3m59s
[19:14:59.759] Received PubSub notification, asking Buildbucket for the build status
[19:14:59.779] Build status: STARTED
[19:18:55.861] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:2:0)
[19:18:55.887] Build status: STARTED
[19:18:55.887] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:4:0) after 6m57s
[19:25:52.935] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:4:0)
[19:25:52.963] Build status: STARTED
[19:25:52.963] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:5:0) after 4m8s
[19:30:01.480] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:5:0)
[19:30:01.514] Build status: STARTED
[19:30:01.514] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:6:0) after 7m53s
[19:37:54.737] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:6:0)
[19:37:54.768] Build status: STARTED
[19:37:54.768] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:7:0) after 7m31s
[19:45:25.807] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:7:0)
[19:45:26.074] Build status: STARTED
[19:45:26.074] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:8:0) after 4m6s
[19:49:32.093] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:8:0)
[19:49:32.117] Build status: STARTED
[19:49:32.117] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:9:0) after 2m26s
[19:51:58.136] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:9:0)
[19:51:58.161] Build status: STARTED
[19:51:58.161] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:10:0) after 3m16s
[19:55:14.189] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:10:0)
[19:55:14.211] Build status: STARTED
[19:55:14.211] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:11:0) after 7m44s
[20:02:58.244] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:11:0)
[20:02:58.267] Build status: STARTED
[20:02:58.267] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:12:0) after 4m45s
[20:07:43.291] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:12:0)
[20:07:43.314] Build status: STARTED
[20:07:43.314] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:13:0) after 6m1s
[20:13:44.336] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:13:0)
[20:13:44.362] Build status: STARTED
[20:13:44.362] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:14:0) after 2m30s
[20:16:14.392] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:14:0)
[20:16:14.425] Build status: STARTED
[20:16:14.425] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:15:0) after 5m24s
[20:21:38.393] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:15:0)
[20:21:38.416] Build status: STARTED
[20:21:38.416] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:16:0) after 9m52s
[20:31:30.492] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:16:0)
[20:31:30.525] Build status: STARTED
[20:31:30.525] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:17:0) after 4m43s
[20:36:13.645] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:17:0)
[20:36:13.676] Build status: STARTED
[20:36:13.676] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:18:0) after 8m46s
[20:45:00.066] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:18:0)
[20:45:00.087] Build status: STARTED
[20:45:00.087] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:19:0) after 2m55s
[20:47:55.112] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:19:0)
[20:47:55.139] Build status: STARTED
[20:47:55.140] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:20:0) after 7m51s
[20:55:46.420] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:20:0)
[20:55:46.444] Build status: STARTED
[20:55:46.444] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:21:0) after 2m57s
[20:58:43.482] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:21:0)
[20:58:43.502] Build status: STARTED
[20:58:43.502] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:22:0) after 3m10s
[21:01:53.578] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:22:0)
[21:01:53.600] Build status: STARTED
[21:01:53.600] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:23:0) after 8m37s
[21:10:30.653] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:23:0)
[21:10:30.675] Build status: STARTED
[21:10:30.675] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:24:0) after 7m7s
[21:17:37.695] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:24:0)
[21:17:37.718] Build status: STARTED
[21:17:37.718] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:25:0) after 7m36s
[21:25:13.754] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:25:0)
[21:25:13.785] Build status: STARTED
[21:25:13.785] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:26:0) after 8m18s
[21:33:31.803] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:26:0)
[21:33:31.930] Build status: STARTED
[21:33:31.930] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:27:0) after 6m57s
[21:40:29.012] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:27:0)
[21:40:29.035] Build status: STARTED
[21:40:29.035] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:28:0) after 2m58s
[21:43:27.103] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:28:0)
[21:43:27.194] Build status: STARTED
[21:43:27.194] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:29:0) after 6m11s
[21:49:38.196] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:29:0)
[21:49:38.403] Build status: STARTED
[21:49:38.404] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:30:0) after 8m10s
[21:57:48.532] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:30:0)
[21:57:48.556] Build status: STARTED
[21:57:48.556] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:31:0) after 7m1s
[22:04:49.588] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:31:0)
[22:04:49.610] Build status: STARTED
[22:04:49.610] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:32:0) after 5m21s
[22:10:10.723] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:32:0)
[22:10:10.753] Build status: STARTED
[22:10:10.753] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950149522292191904:33:0) after 5m22s
[22:11:00.338] Received PubSub notification, asking Buildbucket for the build status
[22:11:00.359] Build:
{
"id": "8784719460038849937",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-04-04T19:14:56.334024967Z",
"startTime": "2023-04-04T19:14:59.159930Z",
"endTime": "2023-04-04T22:10:58.976776037Z",
"updateTime": "2023-04-04T22:10:58.976776037Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "ef6a2c5c660caa4034ef97119f6d1891f006fc7a",
"ref": "refs/heads/main"
}
}
}
[22:11:00.359] Invocation finished in 2h56m5.556533506s with status SUCCEEDED