[15:59:20.684] New invocation is queued and will start shortly
[15:59:22.054] Starting the invocation (attempt 1)
[15:59:22.091] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/b56c3e38edc55ab6e518745d06650c9e1a9b4b53"
[15:59:22.091] Popped gitiles commit info from properties and tags
[15:59:22.091] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:59:22.092] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:59:22.093] Buildbucket request:
{
"requestId": "8948802871920554480",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8948802871920554480",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "039efa1c4de367c976de388487c650ae926fc24a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@039efa1c4de367c976de388487c650ae926fc24a",
"title": "039efa1c4de367c976de388487c650ae926fc24a",
"url": "https://fuchsia.googlesource.com/integration/+/039efa1c4de367c976de388487c650ae926fc24a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c0b06bd673c3d3c9e18520cb47341cf68eb5198b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c0b06bd673c3d3c9e18520cb47341cf68eb5198b",
"title": "c0b06bd673c3d3c9e18520cb47341cf68eb5198b",
"url": "https://fuchsia.googlesource.com/integration/+/c0b06bd673c3d3c9e18520cb47341cf68eb5198b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d6d702fd8088cc3272b709d3a31f6836af13094c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d6d702fd8088cc3272b709d3a31f6836af13094c",
"title": "d6d702fd8088cc3272b709d3a31f6836af13094c",
"url": "https://fuchsia.googlesource.com/integration/+/d6d702fd8088cc3272b709d3a31f6836af13094c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8497e117b8f9cc98e84c06ee34895cfd12eb65c6"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8497e117b8f9cc98e84c06ee34895cfd12eb65c6",
"title": "8497e117b8f9cc98e84c06ee34895cfd12eb65c6",
"url": "https://fuchsia.googlesource.com/integration/+/8497e117b8f9cc98e84c06ee34895cfd12eb65c6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c61fff48c8cbabf42b70f876f022a52552aa79e8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c61fff48c8cbabf42b70f876f022a52552aa79e8",
"title": "c61fff48c8cbabf42b70f876f022a52552aa79e8",
"url": "https://fuchsia.googlesource.com/integration/+/c61fff48c8cbabf42b70f876f022a52552aa79e8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b56c3e38edc55ab6e518745d06650c9e1a9b4b53"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b56c3e38edc55ab6e518745d06650c9e1a9b4b53",
"title": "b56c3e38edc55ab6e518745d06650c9e1a9b4b53",
"url": "https://fuchsia.googlesource.com/integration/+/b56c3e38edc55ab6e518745d06650c9e1a9b4b53"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "b56c3e38edc55ab6e518745d06650c9e1a9b4b53",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8948802871920554480"
},
{
"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"
}
}
[15:59:22.541] Scheduled build:
{
"id": "8783372809715909185",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-04-19T15:59:22.160197123Z",
"updateTime": "2023-04-19T15:59:22.160197123Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "b56c3e38edc55ab6e518745d06650c9e1a9b4b53",
"ref": "refs/heads/main"
}
}
}
[15:59:22.541] Task URL: https://cr-buildbucket.appspot.com/build/8783372809715909185
[15:59:22.541] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948802871920554480:2:0) after 3m18s
[16:00:56.424] Received PubSub notification, asking Buildbucket for the build status
[16:00:56.454] Build status: STARTED
[16:02:41.580] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948802871920554480:2:0)
[16:02:41.618] Build status: STARTED
[16:02:41.618] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948802871920554480:4:0) after 7m52s
[16:10:33.698] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948802871920554480:4:0)
[16:10:33.725] Build status: STARTED
[16:10:33.725] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948802871920554480:5:0) after 7m28s
[16:18:01.775] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948802871920554480:5:0)
[16:18:01.806] Build status: STARTED
[16:18:01.806] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948802871920554480:6:0) after 8m37s
[16:26:38.908] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948802871920554480:6:0)
[16:26:38.929] Build status: STARTED
[16:26:38.929] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948802871920554480:7:0) after 5m0s
[16:31:39.231] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948802871920554480:7:0)
[16:31:39.252] Build status: STARTED
[16:31:39.252] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948802871920554480:8:0) after 8m25s
[16:40:04.402] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948802871920554480:8:0)
[16:40:04.423] Build status: STARTED
[16:40:04.423] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948802871920554480:9:0) after 6m32s
[16:46:36.586] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948802871920554480:9:0)
[16:46:36.608] Build status: STARTED
[16:46:36.608] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948802871920554480:10:0) after 1m45s
[16:48:21.629] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948802871920554480:10:0)
[16:48:21.655] Build status: STARTED
[16:48:21.655] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948802871920554480:11:0) after 9m39s
[16:58:01.443] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948802871920554480:11:0)
[16:58:01.474] Build status: STARTED
[16:58:01.474] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948802871920554480:12:0) after 7m13s
[17:05:14.494] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948802871920554480:12:0)
[17:05:14.524] Build status: STARTED
[17:05:14.524] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948802871920554480:13:0) after 2m56s
[17:08:10.542] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948802871920554480:13:0)
[17:08:10.583] Build status: STARTED
[17:08:10.583] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948802871920554480:14:0) after 2m5s
[17:10:15.947] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948802871920554480:14:0)
[17:10:15.972] Build status: STARTED
[17:10:15.972] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948802871920554480:15:0) after 1m57s
[17:12:13.261] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948802871920554480:15:0)
[17:12:13.287] Build status: STARTED
[17:12:13.287] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948802871920554480:16:0) after 3m51s
[17:16:04.404] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948802871920554480:16:0)
[17:16:04.427] Build status: STARTED
[17:16:04.427] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948802871920554480:17:0) after 7m0s
[17:23:05.065] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948802871920554480:17:0)
[17:23:05.118] Build status: STARTED
[17:23:05.118] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948802871920554480:18:0) after 8m17s
[17:31:22.137] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948802871920554480:18:0)
[17:31:22.259] Build status: STARTED
[17:31:22.259] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948802871920554480:19:0) after 7m40s
[17:39:02.369] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948802871920554480:19:0)
[17:39:02.395] Build status: STARTED
[17:39:02.395] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948802871920554480:20:0) after 5m15s
[17:44:17.543] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948802871920554480:20:0)
[17:44:17.565] Build status: STARTED
[17:44:17.565] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948802871920554480:21:0) after 1m7s
[17:45:24.637] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948802871920554480:21:0)
[17:45:24.662] Build status: STARTED
[17:45:24.662] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948802871920554480:22:0) after 4m14s
[17:47:43.965] Received PubSub notification, asking Buildbucket for the build status
[17:47:43.989] Build:
{
"id": "8783372809715909185",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-04-19T15:59:22.160197123Z",
"startTime": "2023-04-19T16:00:55.819092Z",
"endTime": "2023-04-19T17:47:43.052055945Z",
"updateTime": "2023-04-19T17:47:43.052055945Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "b56c3e38edc55ab6e518745d06650c9e1a9b4b53",
"ref": "refs/heads/main"
}
}
}
[17:47:43.989] Invocation finished in 1h48m23.314560627s with status SUCCEEDED