[19:54:28.754] New invocation is queued and will start shortly
[19:54:29.859] Starting the invocation (attempt 1)
[19:54:29.891] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/5a982ea6929aef4a8e95f9923c84d7d003346927"
[19:54:29.891] Popped gitiles commit info from properties and tags
[19:54:29.891] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:54:29.891] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:54:29.892] Buildbucket request:
{
"requestId": "8901677656007837360",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-gce"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8901677656007837360",
"job": "fuchsia/core.x64-gce-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "25668c89ed9545391e84455f358cdd7f425bdd82"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@25668c89ed9545391e84455f358cdd7f425bdd82",
"title": "25668c89ed9545391e84455f358cdd7f425bdd82",
"url": "https://fuchsia.googlesource.com/integration/+/25668c89ed9545391e84455f358cdd7f425bdd82"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "359957e40196d63492dd1d0535dbacb1b9616104"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@359957e40196d63492dd1d0535dbacb1b9616104",
"title": "359957e40196d63492dd1d0535dbacb1b9616104",
"url": "https://fuchsia.googlesource.com/integration/+/359957e40196d63492dd1d0535dbacb1b9616104"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a10251f9a419ef91b2e616f7a57f17f09b19e36a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a10251f9a419ef91b2e616f7a57f17f09b19e36a",
"title": "a10251f9a419ef91b2e616f7a57f17f09b19e36a",
"url": "https://fuchsia.googlesource.com/integration/+/a10251f9a419ef91b2e616f7a57f17f09b19e36a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "11b8e80c7c58459e7b797093acc121df5bdda6bc"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@11b8e80c7c58459e7b797093acc121df5bdda6bc",
"title": "11b8e80c7c58459e7b797093acc121df5bdda6bc",
"url": "https://fuchsia.googlesource.com/integration/+/11b8e80c7c58459e7b797093acc121df5bdda6bc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e28537f4d670bc5b886596b9e8621e91bc6f5547"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e28537f4d670bc5b886596b9e8621e91bc6f5547",
"title": "e28537f4d670bc5b886596b9e8621e91bc6f5547",
"url": "https://fuchsia.googlesource.com/integration/+/e28537f4d670bc5b886596b9e8621e91bc6f5547"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "161c2fc74af1d3ded192fad018e88a9517f27109"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@161c2fc74af1d3ded192fad018e88a9517f27109",
"title": "161c2fc74af1d3ded192fad018e88a9517f27109",
"url": "https://fuchsia.googlesource.com/integration/+/161c2fc74af1d3ded192fad018e88a9517f27109"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "50a5fac47895a851f39772e89909000562cf6559"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@50a5fac47895a851f39772e89909000562cf6559",
"title": "50a5fac47895a851f39772e89909000562cf6559",
"url": "https://fuchsia.googlesource.com/integration/+/50a5fac47895a851f39772e89909000562cf6559"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5693b20be3cc150fd91bdd25d2dd2b4ceb7e0c60"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5693b20be3cc150fd91bdd25d2dd2b4ceb7e0c60",
"title": "5693b20be3cc150fd91bdd25d2dd2b4ceb7e0c60",
"url": "https://fuchsia.googlesource.com/integration/+/5693b20be3cc150fd91bdd25d2dd2b4ceb7e0c60"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "43edf39ba42942a9cd2e74a2995237f767f95385"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@43edf39ba42942a9cd2e74a2995237f767f95385",
"title": "43edf39ba42942a9cd2e74a2995237f767f95385",
"url": "https://fuchsia.googlesource.com/integration/+/43edf39ba42942a9cd2e74a2995237f767f95385"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f6e5f3d51ee1c9ed889f9f431ce44cefc24290ae"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f6e5f3d51ee1c9ed889f9f431ce44cefc24290ae",
"title": "f6e5f3d51ee1c9ed889f9f431ce44cefc24290ae",
"url": "https://fuchsia.googlesource.com/integration/+/f6e5f3d51ee1c9ed889f9f431ce44cefc24290ae"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "400af4649184df569fa1e5338f03dbd992a169f2"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@400af4649184df569fa1e5338f03dbd992a169f2",
"title": "400af4649184df569fa1e5338f03dbd992a169f2",
"url": "https://fuchsia.googlesource.com/integration/+/400af4649184df569fa1e5338f03dbd992a169f2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5d70df0749286111d7c791d5fe87e7b08d82d92c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5d70df0749286111d7c791d5fe87e7b08d82d92c",
"title": "5d70df0749286111d7c791d5fe87e7b08d82d92c",
"url": "https://fuchsia.googlesource.com/integration/+/5d70df0749286111d7c791d5fe87e7b08d82d92c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d046ab70a2dfd38520872969af0ced0e4efcc13c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d046ab70a2dfd38520872969af0ced0e4efcc13c",
"title": "d046ab70a2dfd38520872969af0ced0e4efcc13c",
"url": "https://fuchsia.googlesource.com/integration/+/d046ab70a2dfd38520872969af0ced0e4efcc13c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1b88a3c048c6b62185941eb0c73127064a0ca64c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1b88a3c048c6b62185941eb0c73127064a0ca64c",
"title": "1b88a3c048c6b62185941eb0c73127064a0ca64c",
"url": "https://fuchsia.googlesource.com/integration/+/1b88a3c048c6b62185941eb0c73127064a0ca64c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a20630c4595a42712b009411116bd82d3dd09f68"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a20630c4595a42712b009411116bd82d3dd09f68",
"title": "a20630c4595a42712b009411116bd82d3dd09f68",
"url": "https://fuchsia.googlesource.com/integration/+/a20630c4595a42712b009411116bd82d3dd09f68"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c8829cea8c48c30f16ef151498fd0d79f98db507"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c8829cea8c48c30f16ef151498fd0d79f98db507",
"title": "c8829cea8c48c30f16ef151498fd0d79f98db507",
"url": "https://fuchsia.googlesource.com/integration/+/c8829cea8c48c30f16ef151498fd0d79f98db507"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3880fc334106a5c145fef3dc45c8ce1a939f5478"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3880fc334106a5c145fef3dc45c8ce1a939f5478",
"title": "3880fc334106a5c145fef3dc45c8ce1a939f5478",
"url": "https://fuchsia.googlesource.com/integration/+/3880fc334106a5c145fef3dc45c8ce1a939f5478"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "dbad07c788a7711eeabbeb4d73589929756398eb"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@dbad07c788a7711eeabbeb4d73589929756398eb",
"title": "dbad07c788a7711eeabbeb4d73589929756398eb",
"url": "https://fuchsia.googlesource.com/integration/+/dbad07c788a7711eeabbeb4d73589929756398eb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7e6e616ea674d02a1e6270da76962e4344640058"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7e6e616ea674d02a1e6270da76962e4344640058",
"title": "7e6e616ea674d02a1e6270da76962e4344640058",
"url": "https://fuchsia.googlesource.com/integration/+/7e6e616ea674d02a1e6270da76962e4344640058"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "667c756ee1c3ae36c561504795f1130a3beff875"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@667c756ee1c3ae36c561504795f1130a3beff875",
"title": "667c756ee1c3ae36c561504795f1130a3beff875",
"url": "https://fuchsia.googlesource.com/integration/+/667c756ee1c3ae36c561504795f1130a3beff875"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f1a256b9f6978e89d54ddcecec1a9c2c040822fa"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f1a256b9f6978e89d54ddcecec1a9c2c040822fa",
"title": "f1a256b9f6978e89d54ddcecec1a9c2c040822fa",
"url": "https://fuchsia.googlesource.com/integration/+/f1a256b9f6978e89d54ddcecec1a9c2c040822fa"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "59514c9773a4940f09918710facb35a57a5da012"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@59514c9773a4940f09918710facb35a57a5da012",
"title": "59514c9773a4940f09918710facb35a57a5da012",
"url": "https://fuchsia.googlesource.com/integration/+/59514c9773a4940f09918710facb35a57a5da012"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5a982ea6929aef4a8e95f9923c84d7d003346927"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5a982ea6929aef4a8e95f9923c84d7d003346927",
"title": "5a982ea6929aef4a8e95f9923c84d7d003346927",
"url": "https://fuchsia.googlesource.com/integration/+/5a982ea6929aef4a8e95f9923c84d7d003346927"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "5a982ea6929aef4a8e95f9923c84d7d003346927",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8901677656007837360"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/core.x64-gce-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[19:54:30.365] Scheduled build:
{
"id": "8736247594095180209",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-gce"
},
"createdBy": "project:fuchsia",
"createTime": "2024-09-20T19:54:29.953501892Z",
"updateTime": "2024-09-20T19:54:29.953501892Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "5a982ea6929aef4a8e95f9923c84d7d003346927",
"ref": "refs/heads/main"
}
}
}
[19:54:30.365] Task URL: https://cr-buildbucket.appspot.com/build/8736247594095180209
[19:54:30.365] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-gce-e5a0ec7f:8901677656007837360:2:0) after 9m13s
[19:54:31.253] Received PubSub notification, asking Buildbucket for the build status
[19:54:31.277] Build status: SCHEDULED
[19:54:36.836] Received PubSub notification, asking Buildbucket for the build status
[19:54:36.862] Build status: STARTED
[20:03:43.386] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-gce-e5a0ec7f:8901677656007837360:2:0)
[20:03:43.454] Build status: STARTED
[20:03:43.454] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-gce-e5a0ec7f:8901677656007837360:5:0) after 7m0s
[20:10:43.472] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-gce-e5a0ec7f:8901677656007837360:5:0)
[20:10:43.501] Build status: STARTED
[20:10:43.501] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-gce-e5a0ec7f:8901677656007837360:6:0) after 5m5s
[20:15:48.550] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-gce-e5a0ec7f:8901677656007837360:6:0)
[20:15:48.669] Build status: STARTED
[20:15:48.669] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-gce-e5a0ec7f:8901677656007837360:7:0) after 4m23s
[20:20:11.723] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-gce-e5a0ec7f:8901677656007837360:7:0)
[20:20:11.748] Build status: STARTED
[20:20:11.748] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-gce-e5a0ec7f:8901677656007837360:8:0) after 7m12s
[20:27:23.841] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-gce-e5a0ec7f:8901677656007837360:8:0)
[20:27:23.858] Build status: STARTED
[20:27:23.858] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-gce-e5a0ec7f:8901677656007837360:9:0) after 6m23s
[20:33:46.888] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-gce-e5a0ec7f:8901677656007837360:9:0)
[20:33:46.914] Build status: STARTED
[20:33:46.914] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-gce-e5a0ec7f:8901677656007837360:10:0) after 3m19s
[20:37:05.967] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-gce-e5a0ec7f:8901677656007837360:10:0)
[20:37:05.986] Build status: STARTED
[20:37:06.060] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-gce-e5a0ec7f:8901677656007837360:11:0) after 7m3s
[20:44:09.114] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-gce-e5a0ec7f:8901677656007837360:11:0)
[20:44:09.138] Build status: STARTED
[20:44:09.138] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-gce-e5a0ec7f:8901677656007837360:12:0) after 9m52s
[20:54:01.251] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-gce-e5a0ec7f:8901677656007837360:12:0)
[20:54:01.269] Build status: STARTED
[20:54:01.269] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-gce-e5a0ec7f:8901677656007837360:13:0) after 1m29s
[20:55:30.335] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-gce-e5a0ec7f:8901677656007837360:13:0)
[20:55:30.350] Build status: STARTED
[20:55:30.350] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-gce-e5a0ec7f:8901677656007837360:14:0) after 2m19s
[20:57:49.383] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-gce-e5a0ec7f:8901677656007837360:14:0)
[20:57:49.403] Build status: STARTED
[20:57:49.403] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-gce-e5a0ec7f:8901677656007837360:15:0) after 8m46s
[21:06:35.425] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-gce-e5a0ec7f:8901677656007837360:15:0)
[21:06:35.465] Build status: STARTED
[21:06:35.465] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-gce-e5a0ec7f:8901677656007837360:16:0) after 8m46s
[21:15:21.561] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-gce-e5a0ec7f:8901677656007837360:16:0)
[21:15:21.607] Build status: STARTED
[21:15:21.607] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-gce-e5a0ec7f:8901677656007837360:17:0) after 6m25s
[21:21:46.639] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-gce-e5a0ec7f:8901677656007837360:17:0)
[21:21:46.666] Build status: STARTED
[21:21:46.666] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-gce-e5a0ec7f:8901677656007837360:18:0) after 9m59s
[21:24:33.357] Received PubSub notification, asking Buildbucket for the build status
[21:24:33.388] Build:
{
"id": "8736247594095180209",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-gce"
},
"createdBy": "project:fuchsia",
"createTime": "2024-09-20T19:54:29.953501892Z",
"startTime": "2024-09-20T19:54:36.652925236Z",
"endTime": "2024-09-20T21:24:33.000282418Z",
"updateTime": "2024-09-20T21:24:33.000282418Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "5a982ea6929aef4a8e95f9923c84d7d003346927",
"ref": "refs/heads/main"
}
}
}
[21:24:33.388] Invocation finished in 1h30m4.643628878s with status SUCCEEDED