[09:21:15.447] New invocation is queued and will start shortly
[09:21:16.495] Starting the invocation (attempt 1)
[09:21:16.524] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/61c0bcd92e890f93e8f651db8ddade5c5994e125"
[09:21:16.524] Popped gitiles commit info from properties and tags
[09:21:16.524] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:21:16.524] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:21:16.525] Buildbucket request:
{
"requestId": "8961873880572052640",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "fuchsia-docs-roller"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8961873880572052640",
"job": "fuchsia/fuchsia-docs-roller-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "13ecdfe893ed31db1e8fb86503970ff5387c1e84"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@13ecdfe893ed31db1e8fb86503970ff5387c1e84",
"title": "13ecdfe893ed31db1e8fb86503970ff5387c1e84",
"url": "https://fuchsia.googlesource.com/integration/+/13ecdfe893ed31db1e8fb86503970ff5387c1e84"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e658f72966095a10e560740903b751af0743952f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e658f72966095a10e560740903b751af0743952f",
"title": "e658f72966095a10e560740903b751af0743952f",
"url": "https://fuchsia.googlesource.com/integration/+/e658f72966095a10e560740903b751af0743952f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f82fbfbd09a55b9f696eb394c9a7b2e3c1cfcf7b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f82fbfbd09a55b9f696eb394c9a7b2e3c1cfcf7b",
"title": "f82fbfbd09a55b9f696eb394c9a7b2e3c1cfcf7b",
"url": "https://fuchsia.googlesource.com/integration/+/f82fbfbd09a55b9f696eb394c9a7b2e3c1cfcf7b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "cd67165f0f875bf39ec8565403c97f56705cc04b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@cd67165f0f875bf39ec8565403c97f56705cc04b",
"title": "cd67165f0f875bf39ec8565403c97f56705cc04b",
"url": "https://fuchsia.googlesource.com/integration/+/cd67165f0f875bf39ec8565403c97f56705cc04b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "742a43a6d554d681a9362bbcfffa0851314dd9c4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@742a43a6d554d681a9362bbcfffa0851314dd9c4",
"title": "742a43a6d554d681a9362bbcfffa0851314dd9c4",
"url": "https://fuchsia.googlesource.com/integration/+/742a43a6d554d681a9362bbcfffa0851314dd9c4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "bd79602a89e0e88396e6be51e7b1a7241e4aa44f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@bd79602a89e0e88396e6be51e7b1a7241e4aa44f",
"title": "bd79602a89e0e88396e6be51e7b1a7241e4aa44f",
"url": "https://fuchsia.googlesource.com/integration/+/bd79602a89e0e88396e6be51e7b1a7241e4aa44f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2cc8d1c19d437769ca07eb641221d92134d0e100"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2cc8d1c19d437769ca07eb641221d92134d0e100",
"title": "2cc8d1c19d437769ca07eb641221d92134d0e100",
"url": "https://fuchsia.googlesource.com/integration/+/2cc8d1c19d437769ca07eb641221d92134d0e100"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "563b810d19b68d58fbc6c3e080bcf9d364722631"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@563b810d19b68d58fbc6c3e080bcf9d364722631",
"title": "563b810d19b68d58fbc6c3e080bcf9d364722631",
"url": "https://fuchsia.googlesource.com/integration/+/563b810d19b68d58fbc6c3e080bcf9d364722631"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3439d99f2b94edaf2ad46f686b7bdfd9bf3e594b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3439d99f2b94edaf2ad46f686b7bdfd9bf3e594b",
"title": "3439d99f2b94edaf2ad46f686b7bdfd9bf3e594b",
"url": "https://fuchsia.googlesource.com/integration/+/3439d99f2b94edaf2ad46f686b7bdfd9bf3e594b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f3b7faa6c89d48b0de290d71cf3f6e8cee1af58b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f3b7faa6c89d48b0de290d71cf3f6e8cee1af58b",
"title": "f3b7faa6c89d48b0de290d71cf3f6e8cee1af58b",
"url": "https://fuchsia.googlesource.com/integration/+/f3b7faa6c89d48b0de290d71cf3f6e8cee1af58b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "44b37ba2400da02b4ec96525108e22f4bd81e800"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@44b37ba2400da02b4ec96525108e22f4bd81e800",
"title": "44b37ba2400da02b4ec96525108e22f4bd81e800",
"url": "https://fuchsia.googlesource.com/integration/+/44b37ba2400da02b4ec96525108e22f4bd81e800"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "61c0bcd92e890f93e8f651db8ddade5c5994e125"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@61c0bcd92e890f93e8f651db8ddade5c5994e125",
"title": "61c0bcd92e890f93e8f651db8ddade5c5994e125",
"url": "https://fuchsia.googlesource.com/integration/+/61c0bcd92e890f93e8f651db8ddade5c5994e125"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "61c0bcd92e890f93e8f651db8ddade5c5994e125",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8961873880572052640"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/fuchsia-docs-roller-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[09:21:16.810] Scheduled build:
{
"id": "8796443818712928705",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "fuchsia-docs-roller"
},
"createdBy": "project:fuchsia",
"createTime": "2022-11-26T09:21:16.590352624Z",
"updateTime": "2022-11-26T09:21:16.590352624Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "61c0bcd92e890f93e8f651db8ddade5c5994e125",
"ref": "refs/heads/main"
}
}
}
[09:21:16.810] Task URL: https://cr-buildbucket.appspot.com/build/8796443818712928705
[09:21:16.810] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-docs-roller-e5a0ec7f:8961873880572052640:2:0) after 2m51s
[09:21:21.284] Received PubSub notification, asking Buildbucket for the build status
[09:21:21.304] Build status: STARTED
[09:24:07.889] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-docs-roller-e5a0ec7f:8961873880572052640:2:0)
[09:24:07.908] Build status: STARTED
[09:24:07.908] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-docs-roller-e5a0ec7f:8961873880572052640:4:0) after 1m44s
[09:25:51.965] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-docs-roller-e5a0ec7f:8961873880572052640:4:0)
[09:25:51.989] Build status: STARTED
[09:25:51.989] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-docs-roller-e5a0ec7f:8961873880572052640:5:0) after 8m40s
[09:34:32.013] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-docs-roller-e5a0ec7f:8961873880572052640:5:0)
[09:34:32.050] Build status: STARTED
[09:34:32.050] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-docs-roller-e5a0ec7f:8961873880572052640:6:0) after 2m43s
[09:37:15.067] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-docs-roller-e5a0ec7f:8961873880572052640:6:0)
[09:37:15.101] Build status: STARTED
[09:37:15.101] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-docs-roller-e5a0ec7f:8961873880572052640:7:0) after 4m3s
[09:37:43.226] Received PubSub notification, asking Buildbucket for the build status
[09:37:43.256] Build:
{
"id": "8796443818712928705",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "fuchsia-docs-roller"
},
"createdBy": "project:fuchsia",
"createTime": "2022-11-26T09:21:16.590352624Z",
"startTime": "2022-11-26T09:21:20.229296Z",
"endTime": "2022-11-26T09:37:42.636774840Z",
"updateTime": "2022-11-26T09:37:42.636774840Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "61c0bcd92e890f93e8f651db8ddade5c5994e125",
"ref": "refs/heads/main"
}
}
}
[09:37:43.256] Invocation finished in 16m27.821989653s with status SUCCEEDED