[04:08:14.353] New invocation is queued and will start shortly
[04:08:15.469] Starting the invocation (attempt 1)
[04:08:15.502] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/fuchsia/+/8fa39e1180e2ec8a3837fe0a007f5a790bd0390b"
[04:08:15.502] Popped gitiles commit info from properties and tags
[04:08:15.502] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:08:15.502] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:08:15.503] Buildbucket request:
{
"requestId": "8889234806926590032",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "fuchsia-profile-kernel-minimal.x64-release"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8889234806926590032",
"job": "fuchsia/fuchsia-profile-kernel-minimal.x64-release-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"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "6d58f6cf7a3e544eb28b62d8d2fac1266091fd6f"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@6d58f6cf7a3e544eb28b62d8d2fac1266091fd6f",
"title": "6d58f6cf7a3e544eb28b62d8d2fac1266091fd6f",
"url": "https://fuchsia.googlesource.com/fuchsia/+/6d58f6cf7a3e544eb28b62d8d2fac1266091fd6f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "1037ef20df897148fef41391db30e84c53efa12e"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@1037ef20df897148fef41391db30e84c53efa12e",
"title": "1037ef20df897148fef41391db30e84c53efa12e",
"url": "https://fuchsia.googlesource.com/fuchsia/+/1037ef20df897148fef41391db30e84c53efa12e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "7d1500aaabae255ccc58cce35bb6e11a0106a3a9"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@7d1500aaabae255ccc58cce35bb6e11a0106a3a9",
"title": "7d1500aaabae255ccc58cce35bb6e11a0106a3a9",
"url": "https://fuchsia.googlesource.com/fuchsia/+/7d1500aaabae255ccc58cce35bb6e11a0106a3a9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "9b5a5ae3dfff131ec7e03dab92e00564a5074572"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@9b5a5ae3dfff131ec7e03dab92e00564a5074572",
"title": "9b5a5ae3dfff131ec7e03dab92e00564a5074572",
"url": "https://fuchsia.googlesource.com/fuchsia/+/9b5a5ae3dfff131ec7e03dab92e00564a5074572"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "523ea446c771925c960c255f137ba88cff6e437b"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@523ea446c771925c960c255f137ba88cff6e437b",
"title": "523ea446c771925c960c255f137ba88cff6e437b",
"url": "https://fuchsia.googlesource.com/fuchsia/+/523ea446c771925c960c255f137ba88cff6e437b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "5c0c3f6d8b093e37e5d123d3616c8040b7d4f02d"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@5c0c3f6d8b093e37e5d123d3616c8040b7d4f02d",
"title": "5c0c3f6d8b093e37e5d123d3616c8040b7d4f02d",
"url": "https://fuchsia.googlesource.com/fuchsia/+/5c0c3f6d8b093e37e5d123d3616c8040b7d4f02d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "8fa39e1180e2ec8a3837fe0a007f5a790bd0390b"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@8fa39e1180e2ec8a3837fe0a007f5a790bd0390b",
"title": "8fa39e1180e2ec8a3837fe0a007f5a790bd0390b",
"url": "https://fuchsia.googlesource.com/fuchsia/+/8fa39e1180e2ec8a3837fe0a007f5a790bd0390b"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "fuchsia",
"id": "8fa39e1180e2ec8a3837fe0a007f5a790bd0390b",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8889234806926590032"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/fuchsia-profile-kernel-minimal.x64-release-af244ac6"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[04:08:16.009] Scheduled build:
{
"id": "8723804744971232593",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "fuchsia-profile-kernel-minimal.x64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2025-02-05T04:08:15.585466801Z",
"updateTime": "2025-02-05T04:08:15.585466801Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "fuchsia",
"id": "8fa39e1180e2ec8a3837fe0a007f5a790bd0390b",
"ref": "refs/heads/main"
}
}
}
[04:08:16.009] Task URL: https://cr-buildbucket.appspot.com/build/8723804744971232593
[04:08:16.009] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.x64-release-af244ac6:8889234806926590032:2:0) after 2m32s
[04:08:17.004] Received PubSub notification, asking Buildbucket for the build status
[04:08:17.107] Build status: SCHEDULED
[04:08:20.469] Received PubSub notification, asking Buildbucket for the build status
[04:08:20.494] Build status: STARTED
[04:10:48.031] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.x64-release-af244ac6:8889234806926590032:2:0)
[04:10:48.086] Build status: STARTED
[04:10:48.086] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.x64-release-af244ac6:8889234806926590032:5:0) after 6m27s
[04:17:15.144] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.x64-release-af244ac6:8889234806926590032:5:0)
[04:17:15.165] Build status: STARTED
[04:17:15.165] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.x64-release-af244ac6:8889234806926590032:6:0) after 6m14s
[04:23:29.313] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.x64-release-af244ac6:8889234806926590032:6:0)
[04:23:29.335] Build status: STARTED
[04:23:29.335] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.x64-release-af244ac6:8889234806926590032:7:0) after 1m1s
[04:24:30.357] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.x64-release-af244ac6:8889234806926590032:7:0)
[04:24:30.397] Build status: STARTED
[04:24:30.397] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.x64-release-af244ac6:8889234806926590032:8:0) after 8m30s
[04:33:00.494] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.x64-release-af244ac6:8889234806926590032:8:0)
[04:33:00.516] Build status: STARTED
[04:33:00.516] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.x64-release-af244ac6:8889234806926590032:9:0) after 6m13s
[04:39:13.576] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.x64-release-af244ac6:8889234806926590032:9:0)
[04:39:13.607] Build status: STARTED
[04:39:13.607] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.x64-release-af244ac6:8889234806926590032:10:0) after 6m52s
[04:46:05.761] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.x64-release-af244ac6:8889234806926590032:10:0)
[04:46:05.789] Build status: STARTED
[04:46:05.789] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.x64-release-af244ac6:8889234806926590032:11:0) after 1m42s
[04:47:47.816] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.x64-release-af244ac6:8889234806926590032:11:0)
[04:47:47.839] Build status: STARTED
[04:47:47.839] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.x64-release-af244ac6:8889234806926590032:12:0) after 2m16s
[04:50:03.857] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.x64-release-af244ac6:8889234806926590032:12:0)
[04:50:03.893] Build status: STARTED
[04:50:03.893] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.x64-release-af244ac6:8889234806926590032:13:0) after 8m10s
[04:58:13.913] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.x64-release-af244ac6:8889234806926590032:13:0)
[04:58:13.934] Build status: STARTED
[04:58:13.934] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.x64-release-af244ac6:8889234806926590032:14:0) after 1m47s
[05:00:01.064] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.x64-release-af244ac6:8889234806926590032:14:0)
[05:00:01.144] Build status: STARTED
[05:00:01.144] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.x64-release-af244ac6:8889234806926590032:15:0) after 2m19s
[05:02:20.235] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.x64-release-af244ac6:8889234806926590032:15:0)
[05:02:20.262] Build status: STARTED
[05:02:20.262] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.x64-release-af244ac6:8889234806926590032:16:0) after 1m35s
[05:03:55.283] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.x64-release-af244ac6:8889234806926590032:16:0)
[05:03:55.316] Build status: STARTED
[05:03:55.316] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.x64-release-af244ac6:8889234806926590032:17:0) after 3m44s
[05:07:39.339] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.x64-release-af244ac6:8889234806926590032:17:0)
[05:07:39.369] Build status: STARTED
[05:07:39.369] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.x64-release-af244ac6:8889234806926590032:18:0) after 6m42s
[05:14:21.438] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.x64-release-af244ac6:8889234806926590032:18:0)
[05:14:21.460] Build status: STARTED
[05:14:21.460] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.x64-release-af244ac6:8889234806926590032:19:0) after 3m35s
[05:17:56.486] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.x64-release-af244ac6:8889234806926590032:19:0)
[05:17:56.506] Build status: STARTED
[05:17:56.506] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.x64-release-af244ac6:8889234806926590032:20:0) after 6m16s
[05:22:52.305] Received PubSub notification, asking Buildbucket for the build status
[05:22:52.330] Build:
{
"id": "8723804744971232593",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "fuchsia-profile-kernel-minimal.x64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2025-02-05T04:08:15.585466801Z",
"startTime": "2025-02-05T04:08:20.033565520Z",
"endTime": "2025-02-05T05:22:52.033525997Z",
"updateTime": "2025-02-05T05:22:52.033525997Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "fuchsia",
"id": "8fa39e1180e2ec8a3837fe0a007f5a790bd0390b",
"ref": "refs/heads/main"
}
}
}
[05:22:52.330] Invocation finished in 1h14m37.992421399s with status SUCCEEDED