[03:17:22.772] New invocation is queued and will start shortly
[03:17:24.239] Starting the invocation (attempt 1)
[03:17:24.273] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/1dd2d4a2c227850ea284a47f5811ce2fd1a79e7d"
[03:17:24.273] Popped gitiles commit info from properties and tags
[03:17:24.273] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:17:24.274] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:17:24.275] Buildbucket request:
{
"requestId": "8946857677362124704",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8946857677362124704",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "fc1064d971dc11c85c027da38774bdec2e1fe9bf"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@fc1064d971dc11c85c027da38774bdec2e1fe9bf",
"title": "fc1064d971dc11c85c027da38774bdec2e1fe9bf",
"url": "https://fuchsia.googlesource.com/integration/+/fc1064d971dc11c85c027da38774bdec2e1fe9bf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e94bd1ef31a9ae1ea4546dd452925b5af8b2a57d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e94bd1ef31a9ae1ea4546dd452925b5af8b2a57d",
"title": "e94bd1ef31a9ae1ea4546dd452925b5af8b2a57d",
"url": "https://fuchsia.googlesource.com/integration/+/e94bd1ef31a9ae1ea4546dd452925b5af8b2a57d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "381bcf63e6ed7e6adc0562afc45a240cdb464cf3"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@381bcf63e6ed7e6adc0562afc45a240cdb464cf3",
"title": "381bcf63e6ed7e6adc0562afc45a240cdb464cf3",
"url": "https://fuchsia.googlesource.com/integration/+/381bcf63e6ed7e6adc0562afc45a240cdb464cf3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ead4e404619ee2dd6345692ae21b9526b83ceb52"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ead4e404619ee2dd6345692ae21b9526b83ceb52",
"title": "ead4e404619ee2dd6345692ae21b9526b83ceb52",
"url": "https://fuchsia.googlesource.com/integration/+/ead4e404619ee2dd6345692ae21b9526b83ceb52"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f173db3cce1abec18340fd963bfe08c6b999f895"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f173db3cce1abec18340fd963bfe08c6b999f895",
"title": "f173db3cce1abec18340fd963bfe08c6b999f895",
"url": "https://fuchsia.googlesource.com/integration/+/f173db3cce1abec18340fd963bfe08c6b999f895"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "94f566f2cc8b6430589d1b5d90566ebf4f8d1fd6"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@94f566f2cc8b6430589d1b5d90566ebf4f8d1fd6",
"title": "94f566f2cc8b6430589d1b5d90566ebf4f8d1fd6",
"url": "https://fuchsia.googlesource.com/integration/+/94f566f2cc8b6430589d1b5d90566ebf4f8d1fd6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d2d947aa9dc194e2be59fd79c0aae0cdbe87dcce"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d2d947aa9dc194e2be59fd79c0aae0cdbe87dcce",
"title": "d2d947aa9dc194e2be59fd79c0aae0cdbe87dcce",
"url": "https://fuchsia.googlesource.com/integration/+/d2d947aa9dc194e2be59fd79c0aae0cdbe87dcce"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "65b6dfaa7357cb28ff22d3cf89819422f1f537cd"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@65b6dfaa7357cb28ff22d3cf89819422f1f537cd",
"title": "65b6dfaa7357cb28ff22d3cf89819422f1f537cd",
"url": "https://fuchsia.googlesource.com/integration/+/65b6dfaa7357cb28ff22d3cf89819422f1f537cd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ceab7677e6951ceb55f1f151b11b91385e6a45db"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ceab7677e6951ceb55f1f151b11b91385e6a45db",
"title": "ceab7677e6951ceb55f1f151b11b91385e6a45db",
"url": "https://fuchsia.googlesource.com/integration/+/ceab7677e6951ceb55f1f151b11b91385e6a45db"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3a720d7334b0746ddcce4e4b864c585fccdeee32"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3a720d7334b0746ddcce4e4b864c585fccdeee32",
"title": "3a720d7334b0746ddcce4e4b864c585fccdeee32",
"url": "https://fuchsia.googlesource.com/integration/+/3a720d7334b0746ddcce4e4b864c585fccdeee32"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a31700a2ecae755767dea14b642b01a43cceb5d1"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a31700a2ecae755767dea14b642b01a43cceb5d1",
"title": "a31700a2ecae755767dea14b642b01a43cceb5d1",
"url": "https://fuchsia.googlesource.com/integration/+/a31700a2ecae755767dea14b642b01a43cceb5d1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1dd2d4a2c227850ea284a47f5811ce2fd1a79e7d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1dd2d4a2c227850ea284a47f5811ce2fd1a79e7d",
"title": "1dd2d4a2c227850ea284a47f5811ce2fd1a79e7d",
"url": "https://fuchsia.googlesource.com/integration/+/1dd2d4a2c227850ea284a47f5811ce2fd1a79e7d"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "1dd2d4a2c227850ea284a47f5811ce2fd1a79e7d",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8946857677362124704"
},
{
"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"
}
}
[03:17:24.698] Scheduled build:
{
"id": "8781427615037965633",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-05-11T03:17:24.365607637Z",
"updateTime": "2023-05-11T03:17:24.365607637Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "1dd2d4a2c227850ea284a47f5811ce2fd1a79e7d",
"ref": "refs/heads/main"
}
}
}
[03:17:24.698] Task URL: https://cr-buildbucket.appspot.com/build/8781427615037965633
[03:17:24.698] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946857677362124704:2:0) after 4m52s
[03:17:56.855] Received PubSub notification, asking Buildbucket for the build status
[03:17:56.876] Build status: STARTED
[03:22:16.668] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946857677362124704:2:0)
[03:22:16.687] Build status: STARTED
[03:22:16.687] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946857677362124704:4:0) after 1m38s
[03:23:54.679] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946857677362124704:4:0)
[03:23:54.699] Build status: STARTED
[03:23:54.700] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946857677362124704:5:0) after 7m15s
[03:31:09.770] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946857677362124704:5:0)
[03:31:09.790] Build status: STARTED
[03:31:09.790] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946857677362124704:6:0) after 5m14s
[03:36:23.808] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946857677362124704:6:0)
[03:36:23.829] Build status: STARTED
[03:36:23.830] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946857677362124704:7:0) after 4m5s
[03:40:28.994] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946857677362124704:7:0)
[03:40:29.053] Build status: STARTED
[03:40:29.053] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946857677362124704:8:0) after 1m11s
[03:41:40.184] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946857677362124704:8:0)
[03:41:40.202] Build status: STARTED
[03:41:40.202] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946857677362124704:9:0) after 9m50s
[03:51:30.227] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946857677362124704:9:0)
[03:51:30.246] Build status: STARTED
[03:51:30.246] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946857677362124704:10:0) after 8m57s
[04:00:27.268] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946857677362124704:10:0)
[04:00:27.288] Build status: STARTED
[04:00:27.288] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946857677362124704:11:0) after 3m27s
[04:03:54.387] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946857677362124704:11:0)
[04:03:54.406] Build status: STARTED
[04:03:54.406] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946857677362124704:12:0) after 3m28s
[04:07:22.818] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946857677362124704:12:0)
[04:07:22.843] Build status: STARTED
[04:07:22.843] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946857677362124704:13:0) after 4m6s
[04:11:28.952] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946857677362124704:13:0)
[04:11:28.990] Build status: STARTED
[04:11:28.990] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946857677362124704:14:0) after 3m50s
[04:15:19.027] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946857677362124704:14:0)
[04:15:19.061] Build status: STARTED
[04:15:19.061] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946857677362124704:15:0) after 2m11s
[04:17:30.312] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946857677362124704:15:0)
[04:17:30.334] Build status: STARTED
[04:17:30.334] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946857677362124704:16:0) after 8m18s
[04:25:48.362] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946857677362124704:16:0)
[04:25:48.386] Build status: STARTED
[04:25:48.386] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946857677362124704:17:0) after 4m34s
[04:30:22.501] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946857677362124704:17:0)
[04:30:22.567] Build status: STARTED
[04:30:22.567] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946857677362124704:18:0) after 7m36s
[04:37:58.719] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946857677362124704:18:0)
[04:37:58.740] Build status: STARTED
[04:37:58.740] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946857677362124704:19:0) after 5m34s
[04:43:32.715] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946857677362124704:19:0)
[04:43:32.732] Build status: STARTED
[04:43:32.732] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946857677362124704:20:0) after 7m42s
[04:51:14.785] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946857677362124704:20:0)
[04:51:14.805] Build status: STARTED
[04:51:14.805] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946857677362124704:21:0) after 4m40s
[04:55:54.821] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946857677362124704:21:0)
[04:55:54.941] Build status: STARTED
[04:55:54.941] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946857677362124704:22:0) after 3m27s
[04:58:49.630] Received PubSub notification, asking Buildbucket for the build status
[04:58:49.652] Build:
{
"id": "8781427615037965633",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-05-11T03:17:24.365607637Z",
"startTime": "2023-05-11T03:17:55.971355Z",
"endTime": "2023-05-11T04:58:48.822935566Z",
"updateTime": "2023-05-11T04:58:48.822935566Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "1dd2d4a2c227850ea284a47f5811ce2fd1a79e7d",
"ref": "refs/heads/main"
}
}
}
[04:58:49.652] Invocation finished in 1h41m26.886729023s with status SUCCEEDED