[21:44:55.701] New invocation is queued and will start shortly
[21:44:57.325] Starting the invocation (attempt 1)
[21:44:57.353] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/ac2ef458e4f926f7bb6715891911e64dc5d35439"
[21:44:57.353] Popped gitiles commit info from properties and tags
[21:44:57.353] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:44:57.353] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:44:57.354] Buildbucket request:
{
"requestId": "8959018586887781952",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8959018586887781952",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "822da280a688f91e09f5eb47fc92249c9d1fec29"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@822da280a688f91e09f5eb47fc92249c9d1fec29",
"title": "822da280a688f91e09f5eb47fc92249c9d1fec29",
"url": "https://fuchsia.googlesource.com/integration/+/822da280a688f91e09f5eb47fc92249c9d1fec29"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c77292a95e3cf29cf09f12c15fad5480a663f733"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c77292a95e3cf29cf09f12c15fad5480a663f733",
"title": "c77292a95e3cf29cf09f12c15fad5480a663f733",
"url": "https://fuchsia.googlesource.com/integration/+/c77292a95e3cf29cf09f12c15fad5480a663f733"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a38cf730b9c42bce4278faecbdeefc66cb8be03f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a38cf730b9c42bce4278faecbdeefc66cb8be03f",
"title": "a38cf730b9c42bce4278faecbdeefc66cb8be03f",
"url": "https://fuchsia.googlesource.com/integration/+/a38cf730b9c42bce4278faecbdeefc66cb8be03f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f43364f30a99fb4656d3122c879b5acb19f1e0e1"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f43364f30a99fb4656d3122c879b5acb19f1e0e1",
"title": "f43364f30a99fb4656d3122c879b5acb19f1e0e1",
"url": "https://fuchsia.googlesource.com/integration/+/f43364f30a99fb4656d3122c879b5acb19f1e0e1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5b17239cc7751eb130e5865ddc94235b4b022041"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5b17239cc7751eb130e5865ddc94235b4b022041",
"title": "5b17239cc7751eb130e5865ddc94235b4b022041",
"url": "https://fuchsia.googlesource.com/integration/+/5b17239cc7751eb130e5865ddc94235b4b022041"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "890cd03d333e07cfcbf7eab73ca972a950fb9cda"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@890cd03d333e07cfcbf7eab73ca972a950fb9cda",
"title": "890cd03d333e07cfcbf7eab73ca972a950fb9cda",
"url": "https://fuchsia.googlesource.com/integration/+/890cd03d333e07cfcbf7eab73ca972a950fb9cda"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "88c7482ab4f93085521cd88ae972a9b7f2508a50"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@88c7482ab4f93085521cd88ae972a9b7f2508a50",
"title": "88c7482ab4f93085521cd88ae972a9b7f2508a50",
"url": "https://fuchsia.googlesource.com/integration/+/88c7482ab4f93085521cd88ae972a9b7f2508a50"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a8872a3cd22ef849de5271db0303158f38aacb11"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a8872a3cd22ef849de5271db0303158f38aacb11",
"title": "a8872a3cd22ef849de5271db0303158f38aacb11",
"url": "https://fuchsia.googlesource.com/integration/+/a8872a3cd22ef849de5271db0303158f38aacb11"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "be5137290ee45ddd158c5278761248c40870d4fd"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@be5137290ee45ddd158c5278761248c40870d4fd",
"title": "be5137290ee45ddd158c5278761248c40870d4fd",
"url": "https://fuchsia.googlesource.com/integration/+/be5137290ee45ddd158c5278761248c40870d4fd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0ca8deb4f097a757cd7168b827a096fdab3a5820"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0ca8deb4f097a757cd7168b827a096fdab3a5820",
"title": "0ca8deb4f097a757cd7168b827a096fdab3a5820",
"url": "https://fuchsia.googlesource.com/integration/+/0ca8deb4f097a757cd7168b827a096fdab3a5820"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0aa860bba46f639113f84a7106a44cc4eafab067"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0aa860bba46f639113f84a7106a44cc4eafab067",
"title": "0aa860bba46f639113f84a7106a44cc4eafab067",
"url": "https://fuchsia.googlesource.com/integration/+/0aa860bba46f639113f84a7106a44cc4eafab067"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b1f3904dfcd5f8c80608d2eaa9924fe28821d865"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b1f3904dfcd5f8c80608d2eaa9924fe28821d865",
"title": "b1f3904dfcd5f8c80608d2eaa9924fe28821d865",
"url": "https://fuchsia.googlesource.com/integration/+/b1f3904dfcd5f8c80608d2eaa9924fe28821d865"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1eafc6c37f0f133af9a50a52581f858ae53d9ce8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1eafc6c37f0f133af9a50a52581f858ae53d9ce8",
"title": "1eafc6c37f0f133af9a50a52581f858ae53d9ce8",
"url": "https://fuchsia.googlesource.com/integration/+/1eafc6c37f0f133af9a50a52581f858ae53d9ce8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "dd6e93259d53ce67bbcb30ef7c9715995d804d7d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@dd6e93259d53ce67bbcb30ef7c9715995d804d7d",
"title": "dd6e93259d53ce67bbcb30ef7c9715995d804d7d",
"url": "https://fuchsia.googlesource.com/integration/+/dd6e93259d53ce67bbcb30ef7c9715995d804d7d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c789205635ebffbab4249668ee672dad285c653d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c789205635ebffbab4249668ee672dad285c653d",
"title": "c789205635ebffbab4249668ee672dad285c653d",
"url": "https://fuchsia.googlesource.com/integration/+/c789205635ebffbab4249668ee672dad285c653d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "512950c1e82c464299372ed1c59a126e94eece8c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@512950c1e82c464299372ed1c59a126e94eece8c",
"title": "512950c1e82c464299372ed1c59a126e94eece8c",
"url": "https://fuchsia.googlesource.com/integration/+/512950c1e82c464299372ed1c59a126e94eece8c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ac2ef458e4f926f7bb6715891911e64dc5d35439"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ac2ef458e4f926f7bb6715891911e64dc5d35439",
"title": "ac2ef458e4f926f7bb6715891911e64dc5d35439",
"url": "https://fuchsia.googlesource.com/integration/+/ac2ef458e4f926f7bb6715891911e64dc5d35439"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "ac2ef458e4f926f7bb6715891911e64dc5d35439",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8959018586887781952"
},
{
"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"
}
}
[21:44:57.683] Scheduled build:
{
"id": "8793588524371105953",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2022-12-27T21:44:57.470341103Z",
"updateTime": "2022-12-27T21:44:57.470341103Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "ac2ef458e4f926f7bb6715891911e64dc5d35439",
"ref": "refs/heads/main"
}
}
}
[21:44:57.683] Task URL: https://cr-buildbucket.appspot.com/build/8793588524371105953
[21:44:57.683] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:2:0) after 5m14s
[21:47:50.825] Received PubSub notification, asking Buildbucket for the build status
[21:47:50.848] Build status: STARTED
[21:50:11.714] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:2:0)
[21:50:11.745] Build status: STARTED
[21:50:11.745] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:4:0) after 5m42s
[21:55:53.870] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:4:0)
[21:55:53.897] Build status: STARTED
[21:55:53.897] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:5:0) after 8m10s
[22:04:03.946] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:5:0)
[22:04:03.971] Build status: STARTED
[22:04:03.971] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:6:0) after 8m41s
[22:12:44.989] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:6:0)
[22:12:45.013] Build status: STARTED
[22:12:45.013] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:7:0) after 4m11s
[22:16:56.193] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:7:0)
[22:16:56.280] Build status: STARTED
[22:16:56.280] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:8:0) after 2m24s
[22:19:20.309] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:8:0)
[22:19:20.336] Build status: STARTED
[22:19:20.336] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:9:0) after 7m44s
[22:27:04.360] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:9:0)
[22:27:04.393] Build status: STARTED
[22:27:04.393] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:10:0) after 5m29s
[22:32:33.434] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:10:0)
[22:32:33.466] Build status: STARTED
[22:32:33.466] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:11:0) after 7m30s
[22:40:03.547] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:11:0)
[22:40:03.571] Build status: STARTED
[22:40:03.571] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:12:0) after 6m1s
[22:46:04.669] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:12:0)
[22:46:04.696] Build status: STARTED
[22:46:04.696] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:13:0) after 1m36s
[22:47:40.926] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:13:0)
[22:47:40.956] Build status: STARTED
[22:47:40.956] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:14:0) after 6m20s
[22:54:01.079] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:14:0)
[22:54:01.105] Build status: STARTED
[22:54:01.106] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:15:0) after 1m23s
[22:55:24.133] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:15:0)
[22:55:24.161] Build status: STARTED
[22:55:24.161] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:16:0) after 4m14s
[22:59:38.210] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:16:0)
[22:59:38.236] Build status: STARTED
[22:59:38.236] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:17:0) after 4m43s
[23:04:21.241] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:17:0)
[23:04:21.367] Build status: STARTED
[23:04:21.367] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:18:0) after 9m43s
[23:14:04.410] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:18:0)
[23:14:04.436] Build status: STARTED
[23:14:04.436] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:19:0) after 9m56s
[23:24:00.641] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:19:0)
[23:24:00.666] Build status: STARTED
[23:24:00.666] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:20:0) after 9m13s
[23:33:13.676] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:20:0)
[23:33:13.701] Build status: STARTED
[23:33:13.701] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:21:0) after 7m35s
[23:40:48.762] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:21:0)
[23:40:48.790] Build status: STARTED
[23:40:48.790] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:22:0) after 5m44s
[23:46:32.929] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:22:0)
[23:46:32.958] Build status: STARTED
[23:46:32.958] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:23:0) after 1m18s
[23:47:50.938] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:23:0)
[23:47:50.961] Build status: STARTED
[23:47:50.961] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:24:0) after 8m2s
[23:55:52.979] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:24:0)
[23:55:53.003] Build status: STARTED
[23:55:53.003] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:25:0) after 5m58s
[00:01:51.116] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:25:0)
[00:01:51.150] Build status: STARTED
[00:01:51.150] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:26:0) after 7m24s
[00:09:15.421] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:26:0)
[00:09:15.445] Build status: STARTED
[00:09:15.445] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:27:0) after 6m58s
[00:16:13.464] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:27:0)
[00:16:13.486] Build status: STARTED
[00:16:13.486] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:28:0) after 9m7s
[00:25:20.691] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:28:0)
[00:25:20.712] Build status: STARTED
[00:25:20.712] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:29:0) after 4m52s
[00:30:12.712] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:29:0)
[00:30:12.742] Build status: STARTED
[00:30:12.742] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:30:0) after 4m49s
[00:35:01.943] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:30:0)
[00:35:01.965] Build status: STARTED
[00:35:01.965] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:31:0) after 6m19s
[00:41:21.466] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:31:0)
[00:41:21.517] Build status: STARTED
[00:41:21.517] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:32:0) after 3m33s
[00:44:54.602] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:32:0)
[00:44:54.628] Build status: STARTED
[00:44:54.628] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959018586887781952:33:0) after 8m11s
[00:48:34.652] Received PubSub notification, asking Buildbucket for the build status
[00:48:34.674] Build:
{
"id": "8793588524371105953",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2022-12-27T21:44:57.470341103Z",
"startTime": "2022-12-27T21:47:50.227563Z",
"endTime": "2022-12-28T00:48:34.208583986Z",
"updateTime": "2022-12-28T00:48:34.208583986Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "ac2ef458e4f926f7bb6715891911e64dc5d35439",
"ref": "refs/heads/main"
}
}
}
[00:48:34.674] Invocation finished in 3h3m38.987800048s with status SUCCEEDED