[04:00:15.504] New invocation is queued and will start shortly
[04:00:16.634] Starting the invocation (attempt 1)
[04:00:16.662] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/9b3fe90ad064a73aa98e6fe756a253c1c5216e48"
[04:00:16.662] Popped gitiles commit info from properties and tags
[04:00:16.662] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:00:16.664] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:00:16.664] Buildbucket request:
{
"requestId": "8910163208277024736",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "kythe"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8910163208277024736",
"job": "fuchsia/kythe-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "398f4bf65ab4a1e65759e2f7cb8b2d0a3ff04f63"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@398f4bf65ab4a1e65759e2f7cb8b2d0a3ff04f63",
"title": "398f4bf65ab4a1e65759e2f7cb8b2d0a3ff04f63",
"url": "https://fuchsia.googlesource.com/integration/+/398f4bf65ab4a1e65759e2f7cb8b2d0a3ff04f63"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a38257b7e8bffe391caf502150ecb4689ee652fe"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a38257b7e8bffe391caf502150ecb4689ee652fe",
"title": "a38257b7e8bffe391caf502150ecb4689ee652fe",
"url": "https://fuchsia.googlesource.com/integration/+/a38257b7e8bffe391caf502150ecb4689ee652fe"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7cbe50b2bf11b3dd9cdc041ba27337a986040c84"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7cbe50b2bf11b3dd9cdc041ba27337a986040c84",
"title": "7cbe50b2bf11b3dd9cdc041ba27337a986040c84",
"url": "https://fuchsia.googlesource.com/integration/+/7cbe50b2bf11b3dd9cdc041ba27337a986040c84"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9b3fe90ad064a73aa98e6fe756a253c1c5216e48"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9b3fe90ad064a73aa98e6fe756a253c1c5216e48",
"title": "9b3fe90ad064a73aa98e6fe756a253c1c5216e48",
"url": "https://fuchsia.googlesource.com/integration/+/9b3fe90ad064a73aa98e6fe756a253c1c5216e48"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "9b3fe90ad064a73aa98e6fe756a253c1c5216e48",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8910163208277024736"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/kythe-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[04:00:17.350] Scheduled build:
{
"id": "8744733146205384081",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "kythe"
},
"createdBy": "project:fuchsia",
"createTime": "2024-06-19T04:00:16.845422773Z",
"updateTime": "2024-06-19T04:00:16.845422773Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "9b3fe90ad064a73aa98e6fe756a253c1c5216e48",
"ref": "refs/heads/main"
}
}
}
[04:00:17.350] Task URL: https://cr-buildbucket.appspot.com/build/8744733146205384081
[04:00:17.350] Scheduling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8910163208277024736:2:0) after 5m22s
[04:00:18.226] Received PubSub notification, asking Buildbucket for the build status
[04:00:18.245] Build status: SCHEDULED
[04:00:26.756] Received PubSub notification, asking Buildbucket for the build status
[04:00:26.800] Build status: STARTED
[04:05:39.745] Handling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8910163208277024736:2:0)
[04:05:39.771] Build status: STARTED
[04:05:39.771] Scheduling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8910163208277024736:5:0) after 7m42s
[04:13:21.787] Handling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8910163208277024736:5:0)
[04:13:21.811] Build status: STARTED
[04:13:21.811] Scheduling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8910163208277024736:6:0) after 4m21s
[04:17:42.838] Handling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8910163208277024736:6:0)
[04:17:42.862] Build status: STARTED
[04:17:42.862] Scheduling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8910163208277024736:7:0) after 4m37s
[04:22:20.517] Handling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8910163208277024736:7:0)
[04:22:20.593] Build status: STARTED
[04:22:20.593] Scheduling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8910163208277024736:8:0) after 3m31s
[04:25:51.821] Handling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8910163208277024736:8:0)
[04:25:51.867] Build status: STARTED
[04:25:51.867] Scheduling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8910163208277024736:9:0) after 2m19s
[04:28:10.838] Handling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8910163208277024736:9:0)
[04:28:10.905] Build status: STARTED
[04:28:10.905] Scheduling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8910163208277024736:10:0) after 5m33s
[04:33:43.994] Handling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8910163208277024736:10:0)
[04:33:44.023] Build status: STARTED
[04:33:44.023] Scheduling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8910163208277024736:11:0) after 6m18s
[04:40:02.040] Handling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8910163208277024736:11:0)
[04:40:02.066] Build status: STARTED
[04:40:02.066] Scheduling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8910163208277024736:12:0) after 4m30s
[04:44:32.082] Handling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8910163208277024736:12:0)
[04:44:32.231] Build status: STARTED
[04:44:32.231] Scheduling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8910163208277024736:13:0) after 5m23s
[04:49:55.248] Handling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8910163208277024736:13:0)
[04:49:55.270] Build status: STARTED
[04:49:55.270] Scheduling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8910163208277024736:14:0) after 4m29s
[04:54:24.282] Handling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8910163208277024736:14:0)
[04:54:24.299] Build status: STARTED
[04:54:24.299] Scheduling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8910163208277024736:15:0) after 3m18s
[04:57:42.341] Handling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8910163208277024736:15:0)
[04:57:42.360] Build status: STARTED
[04:57:42.360] Scheduling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8910163208277024736:16:0) after 7m15s
[05:04:57.497] Handling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8910163208277024736:16:0)
[05:04:57.521] Build status: STARTED
[05:04:57.521] Scheduling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8910163208277024736:17:0) after 2m42s
[05:07:40.204] Handling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8910163208277024736:17:0)
[05:07:40.253] Build status: STARTED
[05:07:40.253] Scheduling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8910163208277024736:18:0) after 4m4s
[05:11:44.301] Handling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8910163208277024736:18:0)
[05:11:44.323] Build status: STARTED
[05:11:44.323] Scheduling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8910163208277024736:19:0) after 7m33s
[05:19:17.698] Handling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8910163208277024736:19:0)
[05:19:17.718] Build status: STARTED
[05:19:17.718] Scheduling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8910163208277024736:20:0) after 6m23s
[05:22:32.933] Received PubSub notification, asking Buildbucket for the build status
[05:22:32.950] Build:
{
"id": "8744733146205384081",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "kythe"
},
"createdBy": "project:fuchsia",
"createTime": "2024-06-19T04:00:16.845422773Z",
"startTime": "2024-06-19T04:00:26.528734219Z",
"endTime": "2024-06-19T05:22:32.272645746Z",
"updateTime": "2024-06-19T05:22:32.272645746Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "9b3fe90ad064a73aa98e6fe756a253c1c5216e48",
"ref": "refs/heads/main"
}
}
}
[05:22:32.950] Invocation finished in 1h22m17.464470575s with status SUCCEEDED