[23:45:49.096] New invocation is queued and will start shortly
[23:45:50.161] Starting the invocation (attempt 1)
[23:45:50.192] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/3c7dd0f118ebad14cc5fbf59f60ee71c7f85a886"
[23:45:50.192] Popped gitiles commit info from properties and tags
[23:45:50.192] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:45:50.192] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:45:50.193] Buildbucket request:
{
"requestId": "8948320539114159392",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8948320539114159392",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7867cd0ef1cef2b1df36187de1dece9dc2edd1eb"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7867cd0ef1cef2b1df36187de1dece9dc2edd1eb",
"title": "7867cd0ef1cef2b1df36187de1dece9dc2edd1eb",
"url": "https://fuchsia.googlesource.com/integration/+/7867cd0ef1cef2b1df36187de1dece9dc2edd1eb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "24a5ed23a53f9efda270b7442212e1af7d1dc687"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@24a5ed23a53f9efda270b7442212e1af7d1dc687",
"title": "24a5ed23a53f9efda270b7442212e1af7d1dc687",
"url": "https://fuchsia.googlesource.com/integration/+/24a5ed23a53f9efda270b7442212e1af7d1dc687"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "bdbe03b108ea281367f4c3696f6c005bb6241072"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@bdbe03b108ea281367f4c3696f6c005bb6241072",
"title": "bdbe03b108ea281367f4c3696f6c005bb6241072",
"url": "https://fuchsia.googlesource.com/integration/+/bdbe03b108ea281367f4c3696f6c005bb6241072"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a8dc469752a2ab64ffd72d747a47134f365e155d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a8dc469752a2ab64ffd72d747a47134f365e155d",
"title": "a8dc469752a2ab64ffd72d747a47134f365e155d",
"url": "https://fuchsia.googlesource.com/integration/+/a8dc469752a2ab64ffd72d747a47134f365e155d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6522d8d87cc3bb2615aba39e896b8395c11a5364"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6522d8d87cc3bb2615aba39e896b8395c11a5364",
"title": "6522d8d87cc3bb2615aba39e896b8395c11a5364",
"url": "https://fuchsia.googlesource.com/integration/+/6522d8d87cc3bb2615aba39e896b8395c11a5364"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b475bf6c9777a914a6f48264865b63bb6c920db0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b475bf6c9777a914a6f48264865b63bb6c920db0",
"title": "b475bf6c9777a914a6f48264865b63bb6c920db0",
"url": "https://fuchsia.googlesource.com/integration/+/b475bf6c9777a914a6f48264865b63bb6c920db0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5cf12f4eba281479e57e003b757b3fb88af3635e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5cf12f4eba281479e57e003b757b3fb88af3635e",
"title": "5cf12f4eba281479e57e003b757b3fb88af3635e",
"url": "https://fuchsia.googlesource.com/integration/+/5cf12f4eba281479e57e003b757b3fb88af3635e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "37e03a6620ff97b46d6e2adfa693c0e3034d1bf5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@37e03a6620ff97b46d6e2adfa693c0e3034d1bf5",
"title": "37e03a6620ff97b46d6e2adfa693c0e3034d1bf5",
"url": "https://fuchsia.googlesource.com/integration/+/37e03a6620ff97b46d6e2adfa693c0e3034d1bf5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9a8e1e78b1471c159271a065a799de27a6baac8a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9a8e1e78b1471c159271a065a799de27a6baac8a",
"title": "9a8e1e78b1471c159271a065a799de27a6baac8a",
"url": "https://fuchsia.googlesource.com/integration/+/9a8e1e78b1471c159271a065a799de27a6baac8a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "45bd8b757bba14a944074e342af86e11692c4815"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@45bd8b757bba14a944074e342af86e11692c4815",
"title": "45bd8b757bba14a944074e342af86e11692c4815",
"url": "https://fuchsia.googlesource.com/integration/+/45bd8b757bba14a944074e342af86e11692c4815"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "aeda7209ab1658c2b52899dd3a5f1e9079c9e481"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@aeda7209ab1658c2b52899dd3a5f1e9079c9e481",
"title": "aeda7209ab1658c2b52899dd3a5f1e9079c9e481",
"url": "https://fuchsia.googlesource.com/integration/+/aeda7209ab1658c2b52899dd3a5f1e9079c9e481"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0e1a2cd385e0589c4aa024b882aa5a95963567f7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0e1a2cd385e0589c4aa024b882aa5a95963567f7",
"title": "0e1a2cd385e0589c4aa024b882aa5a95963567f7",
"url": "https://fuchsia.googlesource.com/integration/+/0e1a2cd385e0589c4aa024b882aa5a95963567f7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8461a8dcfaeebd59ba1a843649597b9daa3ea883"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8461a8dcfaeebd59ba1a843649597b9daa3ea883",
"title": "8461a8dcfaeebd59ba1a843649597b9daa3ea883",
"url": "https://fuchsia.googlesource.com/integration/+/8461a8dcfaeebd59ba1a843649597b9daa3ea883"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "29a51fc5f26fe2346b6f9f0f7b60ab2fc39388d8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@29a51fc5f26fe2346b6f9f0f7b60ab2fc39388d8",
"title": "29a51fc5f26fe2346b6f9f0f7b60ab2fc39388d8",
"url": "https://fuchsia.googlesource.com/integration/+/29a51fc5f26fe2346b6f9f0f7b60ab2fc39388d8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3c504efedb6b156842052c5e9838688a438653f9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3c504efedb6b156842052c5e9838688a438653f9",
"title": "3c504efedb6b156842052c5e9838688a438653f9",
"url": "https://fuchsia.googlesource.com/integration/+/3c504efedb6b156842052c5e9838688a438653f9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8419fd5a532c2c520fef31392e9d7a9835151043"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8419fd5a532c2c520fef31392e9d7a9835151043",
"title": "8419fd5a532c2c520fef31392e9d7a9835151043",
"url": "https://fuchsia.googlesource.com/integration/+/8419fd5a532c2c520fef31392e9d7a9835151043"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "baa7f0c017a118088d0c46f09c98920d97f4ea53"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@baa7f0c017a118088d0c46f09c98920d97f4ea53",
"title": "baa7f0c017a118088d0c46f09c98920d97f4ea53",
"url": "https://fuchsia.googlesource.com/integration/+/baa7f0c017a118088d0c46f09c98920d97f4ea53"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "fc7683d11bed4088b4a839163b10a17f5cff6ee0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@fc7683d11bed4088b4a839163b10a17f5cff6ee0",
"title": "fc7683d11bed4088b4a839163b10a17f5cff6ee0",
"url": "https://fuchsia.googlesource.com/integration/+/fc7683d11bed4088b4a839163b10a17f5cff6ee0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "52e4622a2ef7f98a4fb73a3c44840ff960180aaf"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@52e4622a2ef7f98a4fb73a3c44840ff960180aaf",
"title": "52e4622a2ef7f98a4fb73a3c44840ff960180aaf",
"url": "https://fuchsia.googlesource.com/integration/+/52e4622a2ef7f98a4fb73a3c44840ff960180aaf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3c7dd0f118ebad14cc5fbf59f60ee71c7f85a886"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3c7dd0f118ebad14cc5fbf59f60ee71c7f85a886",
"title": "3c7dd0f118ebad14cc5fbf59f60ee71c7f85a886",
"url": "https://fuchsia.googlesource.com/integration/+/3c7dd0f118ebad14cc5fbf59f60ee71c7f85a886"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "3c7dd0f118ebad14cc5fbf59f60ee71c7f85a886",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8948320539114159392"
},
{
"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"
}
}
[23:45:50.787] Scheduled build:
{
"id": "8782890477184107217",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-04-24T23:45:50.308938259Z",
"updateTime": "2023-04-24T23:45:50.308938259Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "3c7dd0f118ebad14cc5fbf59f60ee71c7f85a886",
"ref": "refs/heads/main"
}
},
"canary": true
}
[23:45:50.787] Task URL: https://cr-buildbucket.appspot.com/build/8782890477184107217
[23:45:50.787] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948320539114159392:2:0) after 5m4s
[23:46:05.786] Received PubSub notification, asking Buildbucket for the build status
[23:46:05.837] Build status: STARTED
[23:50:55.341] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948320539114159392:2:0)
[23:50:55.385] Build status: STARTED
[23:50:55.385] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948320539114159392:4:0) after 2m48s
[23:53:43.799] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948320539114159392:4:0)
[23:53:43.818] Build status: STARTED
[23:53:43.818] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948320539114159392:5:0) after 9m26s
[00:03:09.949] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948320539114159392:5:0)
[00:03:09.985] Build status: STARTED
[00:03:09.986] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948320539114159392:6:0) after 1m58s
[00:05:08.102] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948320539114159392:6:0)
[00:05:08.128] Build status: STARTED
[00:05:08.128] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948320539114159392:7:0) after 7m41s
[00:12:49.265] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948320539114159392:7:0)
[00:12:49.288] Build status: STARTED
[00:12:49.288] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948320539114159392:8:0) after 9m47s
[00:22:36.305] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948320539114159392:8:0)
[00:22:36.329] Build status: STARTED
[00:22:36.329] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948320539114159392:9:0) after 8m44s
[00:31:20.682] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948320539114159392:9:0)
[00:31:20.710] Build status: STARTED
[00:31:20.710] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948320539114159392:10:0) after 9m12s
[00:40:32.802] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948320539114159392:10:0)
[00:40:32.833] Build status: STARTED
[00:40:32.833] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948320539114159392:11:0) after 7m46s
[00:48:18.890] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948320539114159392:11:0)
[00:48:18.923] Build status: STARTED
[00:48:18.923] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948320539114159392:12:0) after 7m25s
[00:55:43.983] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948320539114159392:12:0)
[00:55:44.002] Build status: STARTED
[00:55:44.002] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948320539114159392:13:0) after 8m45s
[01:04:29.558] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948320539114159392:13:0)
[01:04:29.583] Build status: STARTED
[01:04:29.584] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948320539114159392:14:0) after 7m15s
[01:11:44.810] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948320539114159392:14:0)
[01:11:44.832] Build status: STARTED
[01:11:44.832] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948320539114159392:15:0) after 4m42s
[01:16:26.851] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948320539114159392:15:0)
[01:16:26.875] Build status: STARTED
[01:16:26.875] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948320539114159392:16:0) after 6m46s
[01:23:12.985] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948320539114159392:16:0)
[01:23:13.016] Build status: STARTED
[01:23:13.016] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948320539114159392:17:0) after 8m57s
[01:31:52.955] Received PubSub notification, asking Buildbucket for the build status
[01:31:52.979] Build:
{
"id": "8782890477184107217",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-04-24T23:45:50.308938259Z",
"startTime": "2023-04-24T23:46:04.343176Z",
"endTime": "2023-04-25T01:31:52.222320609Z",
"updateTime": "2023-04-25T01:31:52.222320609Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "3c7dd0f118ebad14cc5fbf59f60ee71c7f85a886",
"ref": "refs/heads/main"
}
},
"canary": true
}
[01:31:52.979] Invocation finished in 1h46m3.89474528s with status SUCCEEDED