[21:36:10.144] New invocation is queued and will start shortly
[21:36:11.265] Starting the invocation (attempt 1)
[21:36:11.298] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/08405a43962f529e9824e4872068ea37b77c0921"
[21:36:11.298] Popped gitiles commit info from properties and tags
[21:36:11.298] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:36:11.298] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:36:11.298] Buildbucket request:
{
"requestId": "8956120035041096608",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "fuchsia-docs-roller"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8956120035041096608",
"job": "fuchsia/fuchsia-docs-roller-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3c1bb6e83cb8c151f83bced56188486597fd4ee5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3c1bb6e83cb8c151f83bced56188486597fd4ee5",
"title": "3c1bb6e83cb8c151f83bced56188486597fd4ee5",
"url": "https://fuchsia.googlesource.com/integration/+/3c1bb6e83cb8c151f83bced56188486597fd4ee5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1c64dc46ecf5bb92ef405ea6472eadb53f3b0cf7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1c64dc46ecf5bb92ef405ea6472eadb53f3b0cf7",
"title": "1c64dc46ecf5bb92ef405ea6472eadb53f3b0cf7",
"url": "https://fuchsia.googlesource.com/integration/+/1c64dc46ecf5bb92ef405ea6472eadb53f3b0cf7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "cd956f1486bb690ee38c43d5257d2a3e0dbb90ad"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@cd956f1486bb690ee38c43d5257d2a3e0dbb90ad",
"title": "cd956f1486bb690ee38c43d5257d2a3e0dbb90ad",
"url": "https://fuchsia.googlesource.com/integration/+/cd956f1486bb690ee38c43d5257d2a3e0dbb90ad"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "18f43f5b89c3acdcf99db6cc23422648e67728c6"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@18f43f5b89c3acdcf99db6cc23422648e67728c6",
"title": "18f43f5b89c3acdcf99db6cc23422648e67728c6",
"url": "https://fuchsia.googlesource.com/integration/+/18f43f5b89c3acdcf99db6cc23422648e67728c6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "122609da75208fde8b187469cf405ee4f4a521bf"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@122609da75208fde8b187469cf405ee4f4a521bf",
"title": "122609da75208fde8b187469cf405ee4f4a521bf",
"url": "https://fuchsia.googlesource.com/integration/+/122609da75208fde8b187469cf405ee4f4a521bf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "20d6f3bfb71f817561175c827b790c048ca887ad"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@20d6f3bfb71f817561175c827b790c048ca887ad",
"title": "20d6f3bfb71f817561175c827b790c048ca887ad",
"url": "https://fuchsia.googlesource.com/integration/+/20d6f3bfb71f817561175c827b790c048ca887ad"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "08405a43962f529e9824e4872068ea37b77c0921"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@08405a43962f529e9824e4872068ea37b77c0921",
"title": "08405a43962f529e9824e4872068ea37b77c0921",
"url": "https://fuchsia.googlesource.com/integration/+/08405a43962f529e9824e4872068ea37b77c0921"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "08405a43962f529e9824e4872068ea37b77c0921",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8956120035041096608"
},
{
"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"
}
}
[21:36:11.583] Scheduled build:
{
"id": "8790689973105413825",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "fuchsia-docs-roller"
},
"createdBy": "project:fuchsia",
"createTime": "2023-01-28T21:36:11.367309199Z",
"updateTime": "2023-01-28T21:36:11.367309199Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "08405a43962f529e9824e4872068ea37b77c0921",
"ref": "refs/heads/main"
}
}
}
[21:36:11.583] Task URL: https://cr-buildbucket.appspot.com/build/8790689973105413825
[21:36:11.583] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-docs-roller-e5a0ec7f:8956120035041096608:2:0) after 8m19s
[21:36:37.874] Received PubSub notification, asking Buildbucket for the build status
[21:36:37.896] Build status: STARTED
[21:44:30.805] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-docs-roller-e5a0ec7f:8956120035041096608:2:0)
[21:44:30.828] Build status: STARTED
[21:44:30.828] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-docs-roller-e5a0ec7f:8956120035041096608:4:0) after 5m58s
[21:50:29.059] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-docs-roller-e5a0ec7f:8956120035041096608:4:0)
[21:50:29.091] Build status: STARTED
[21:50:29.091] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-docs-roller-e5a0ec7f:8956120035041096608:5:0) after 8m42s
[21:50:50.782] Received PubSub notification, asking Buildbucket for the build status
[21:50:50.803] Build:
{
"id": "8790689973105413825",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "fuchsia-docs-roller"
},
"createdBy": "project:fuchsia",
"createTime": "2023-01-28T21:36:11.367309199Z",
"startTime": "2023-01-28T21:36:37.101167Z",
"endTime": "2023-01-28T21:50:50.415926937Z",
"updateTime": "2023-01-28T21:50:50.415926937Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "08405a43962f529e9824e4872068ea37b77c0921",
"ref": "refs/heads/main"
}
}
}
[21:50:50.803] Invocation finished in 14m40.666355487s with status SUCCEEDED