[03:27:56.169] New invocation is queued and will start shortly
[03:27:57.840] Starting the invocation (attempt 1)
[03:27:57.874] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/fuchsia/+/baf88374cf495d6ebe3fa5e29e196bd829715527"
[03:27:57.874] Popped gitiles commit info from properties and tags
[03:27:57.874] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:27:57.874] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:27:57.875] Buildbucket request:
{
"requestId": "8889237342574486976",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "core.arm64-release-profile"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8889237342574486976",
"job": "fuchsia/core.arm64-release-profile-af244ac6",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "89db49df374e2f29b34e2e8a45b0c8573a7ff8f2"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@89db49df374e2f29b34e2e8a45b0c8573a7ff8f2",
"title": "89db49df374e2f29b34e2e8a45b0c8573a7ff8f2",
"url": "https://fuchsia.googlesource.com/fuchsia/+/89db49df374e2f29b34e2e8a45b0c8573a7ff8f2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "19a172a2518035ff928e91a57c6c4d1039ad7dab"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@19a172a2518035ff928e91a57c6c4d1039ad7dab",
"title": "19a172a2518035ff928e91a57c6c4d1039ad7dab",
"url": "https://fuchsia.googlesource.com/fuchsia/+/19a172a2518035ff928e91a57c6c4d1039ad7dab"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "fd044a21ba568279fb1ae145af5e7f9cbab9633a"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@fd044a21ba568279fb1ae145af5e7f9cbab9633a",
"title": "fd044a21ba568279fb1ae145af5e7f9cbab9633a",
"url": "https://fuchsia.googlesource.com/fuchsia/+/fd044a21ba568279fb1ae145af5e7f9cbab9633a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "55b0a3153aa669e97a34fdd968c5b7a4c4f8cde0"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@55b0a3153aa669e97a34fdd968c5b7a4c4f8cde0",
"title": "55b0a3153aa669e97a34fdd968c5b7a4c4f8cde0",
"url": "https://fuchsia.googlesource.com/fuchsia/+/55b0a3153aa669e97a34fdd968c5b7a4c4f8cde0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "47dff18f41266880a3df16354a4da54d6a859808"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@47dff18f41266880a3df16354a4da54d6a859808",
"title": "47dff18f41266880a3df16354a4da54d6a859808",
"url": "https://fuchsia.googlesource.com/fuchsia/+/47dff18f41266880a3df16354a4da54d6a859808"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "79fcb9aa2a8040f4b59cbb311552357bce8ad296"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@79fcb9aa2a8040f4b59cbb311552357bce8ad296",
"title": "79fcb9aa2a8040f4b59cbb311552357bce8ad296",
"url": "https://fuchsia.googlesource.com/fuchsia/+/79fcb9aa2a8040f4b59cbb311552357bce8ad296"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "f474ad9033fdeedc010a9ec39e472063eb968030"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@f474ad9033fdeedc010a9ec39e472063eb968030",
"title": "f474ad9033fdeedc010a9ec39e472063eb968030",
"url": "https://fuchsia.googlesource.com/fuchsia/+/f474ad9033fdeedc010a9ec39e472063eb968030"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "a0cfcbd318962913ff4eccaec6b4844968208340"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@a0cfcbd318962913ff4eccaec6b4844968208340",
"title": "a0cfcbd318962913ff4eccaec6b4844968208340",
"url": "https://fuchsia.googlesource.com/fuchsia/+/a0cfcbd318962913ff4eccaec6b4844968208340"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "874b7bdf98f9571162c0111a134fd596d5f7ec93"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@874b7bdf98f9571162c0111a134fd596d5f7ec93",
"title": "874b7bdf98f9571162c0111a134fd596d5f7ec93",
"url": "https://fuchsia.googlesource.com/fuchsia/+/874b7bdf98f9571162c0111a134fd596d5f7ec93"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "1b7cebf3e40ac907c97c66ef815596cdf09c0a09"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@1b7cebf3e40ac907c97c66ef815596cdf09c0a09",
"title": "1b7cebf3e40ac907c97c66ef815596cdf09c0a09",
"url": "https://fuchsia.googlesource.com/fuchsia/+/1b7cebf3e40ac907c97c66ef815596cdf09c0a09"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "baf88374cf495d6ebe3fa5e29e196bd829715527"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@baf88374cf495d6ebe3fa5e29e196bd829715527",
"title": "baf88374cf495d6ebe3fa5e29e196bd829715527",
"url": "https://fuchsia.googlesource.com/fuchsia/+/baf88374cf495d6ebe3fa5e29e196bd829715527"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "fuchsia",
"id": "baf88374cf495d6ebe3fa5e29e196bd829715527",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8889237342574486976"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/core.arm64-release-profile-af244ac6"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[03:27:58.246] Scheduled build:
{
"id": "8723807280058541121",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "core.arm64-release-profile"
},
"createdBy": "project:fuchsia",
"createTime": "2025-02-05T03:27:57.938875197Z",
"updateTime": "2025-02-05T03:27:57.938875197Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "fuchsia",
"id": "baf88374cf495d6ebe3fa5e29e196bd829715527",
"ref": "refs/heads/main"
}
}
}
[03:27:58.247] Task URL: https://cr-buildbucket.appspot.com/build/8723807280058541121
[03:27:58.247] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-release-profile-af244ac6:8889237342574486976:2:0) after 2m22s
[03:27:58.525] Received PubSub notification, asking Buildbucket for the build status
[03:27:58.541] Build status: SCHEDULED
[03:28:03.720] Received PubSub notification, asking Buildbucket for the build status
[03:28:03.746] Build status: STARTED
[03:30:20.274] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-release-profile-af244ac6:8889237342574486976:2:0)
[03:30:20.309] Build status: STARTED
[03:30:20.309] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-release-profile-af244ac6:8889237342574486976:5:0) after 4m3s
[03:34:23.426] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-release-profile-af244ac6:8889237342574486976:5:0)
[03:34:23.562] Build status: STARTED
[03:34:23.562] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-release-profile-af244ac6:8889237342574486976:6:0) after 9m1s
[03:43:24.587] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-release-profile-af244ac6:8889237342574486976:6:0)
[03:43:24.611] Build status: STARTED
[03:43:24.611] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-release-profile-af244ac6:8889237342574486976:7:0) after 1m17s
[03:44:41.655] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-release-profile-af244ac6:8889237342574486976:7:0)
[03:44:41.680] Build status: STARTED
[03:44:41.680] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-release-profile-af244ac6:8889237342574486976:8:0) after 9m22s
[03:54:03.782] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-release-profile-af244ac6:8889237342574486976:8:0)
[03:54:03.830] Build status: STARTED
[03:54:03.830] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-release-profile-af244ac6:8889237342574486976:9:0) after 5m40s
[03:59:43.869] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-release-profile-af244ac6:8889237342574486976:9:0)
[03:59:43.891] Build status: STARTED
[03:59:43.891] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-release-profile-af244ac6:8889237342574486976:10:0) after 1m25s
[04:01:08.923] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-release-profile-af244ac6:8889237342574486976:10:0)
[04:01:08.942] Build status: STARTED
[04:01:08.942] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-release-profile-af244ac6:8889237342574486976:11:0) after 4m10s
[04:05:18.962] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-release-profile-af244ac6:8889237342574486976:11:0)
[04:05:18.979] Build status: STARTED
[04:05:18.979] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-release-profile-af244ac6:8889237342574486976:12:0) after 8m3s
[04:13:22.000] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-release-profile-af244ac6:8889237342574486976:12:0)
[04:13:22.028] Build status: STARTED
[04:13:22.028] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-release-profile-af244ac6:8889237342574486976:13:0) after 3m31s
[04:15:55.390] Received PubSub notification, asking Buildbucket for the build status
[04:15:55.409] Build:
{
"id": "8723807280058541121",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "core.arm64-release-profile"
},
"createdBy": "project:fuchsia",
"createTime": "2025-02-05T03:27:57.938875197Z",
"startTime": "2025-02-05T03:28:03.537883494Z",
"endTime": "2025-02-05T04:15:54.959235949Z",
"updateTime": "2025-02-05T04:15:54.959235949Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "fuchsia",
"id": "baf88374cf495d6ebe3fa5e29e196bd829715527",
"ref": "refs/heads/main"
}
}
}
[04:15:55.409] Invocation finished in 47m59.254036476s with status SUCCEEDED