[00:41:23.403] New invocation is queued and will start shortly
[00:41:24.818] Starting the invocation (attempt 1)
[00:41:24.852] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/fuchsia/+/33b21edab0281d35ec4eb671d879e6270f82ea93"
[00:41:24.852] Popped gitiles commit info from properties and tags
[00:41:24.852] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:41:24.852] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:41:24.853] Buildbucket request:
{
"requestId": "8889791402549864928",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "fuchsia-profile-kernel-minimal.arm64-release"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8889791402549864928",
"job": "fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "fae0fa2821ef16d58b768caf40f41b890ee97361"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@fae0fa2821ef16d58b768caf40f41b890ee97361",
"title": "fae0fa2821ef16d58b768caf40f41b890ee97361",
"url": "https://fuchsia.googlesource.com/fuchsia/+/fae0fa2821ef16d58b768caf40f41b890ee97361"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "f8fdcbf1930cf3cf8c0e63470cbdc6a1a4fd6db1"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@f8fdcbf1930cf3cf8c0e63470cbdc6a1a4fd6db1",
"title": "f8fdcbf1930cf3cf8c0e63470cbdc6a1a4fd6db1",
"url": "https://fuchsia.googlesource.com/fuchsia/+/f8fdcbf1930cf3cf8c0e63470cbdc6a1a4fd6db1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "ce2278471c54c43f039755fd78f03ef4eb0eb92b"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@ce2278471c54c43f039755fd78f03ef4eb0eb92b",
"title": "ce2278471c54c43f039755fd78f03ef4eb0eb92b",
"url": "https://fuchsia.googlesource.com/fuchsia/+/ce2278471c54c43f039755fd78f03ef4eb0eb92b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "268c41d3631a383e22f8c5c95e045e342bb56b2b"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@268c41d3631a383e22f8c5c95e045e342bb56b2b",
"title": "268c41d3631a383e22f8c5c95e045e342bb56b2b",
"url": "https://fuchsia.googlesource.com/fuchsia/+/268c41d3631a383e22f8c5c95e045e342bb56b2b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "d486b6eb1a43502538b0362a0f0b8071d027c11d"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@d486b6eb1a43502538b0362a0f0b8071d027c11d",
"title": "d486b6eb1a43502538b0362a0f0b8071d027c11d",
"url": "https://fuchsia.googlesource.com/fuchsia/+/d486b6eb1a43502538b0362a0f0b8071d027c11d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "2007a41d5b746472ba5c031b1bd799172bebe752"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@2007a41d5b746472ba5c031b1bd799172bebe752",
"title": "2007a41d5b746472ba5c031b1bd799172bebe752",
"url": "https://fuchsia.googlesource.com/fuchsia/+/2007a41d5b746472ba5c031b1bd799172bebe752"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "131fe21d852a1111f9893f3cdc5e46a3d455846e"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@131fe21d852a1111f9893f3cdc5e46a3d455846e",
"title": "131fe21d852a1111f9893f3cdc5e46a3d455846e",
"url": "https://fuchsia.googlesource.com/fuchsia/+/131fe21d852a1111f9893f3cdc5e46a3d455846e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "ddb31614cffa5481d92669979e3efbdddae119ee"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@ddb31614cffa5481d92669979e3efbdddae119ee",
"title": "ddb31614cffa5481d92669979e3efbdddae119ee",
"url": "https://fuchsia.googlesource.com/fuchsia/+/ddb31614cffa5481d92669979e3efbdddae119ee"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "806550fb0d427d19196e9709b718ff10316d2327"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@806550fb0d427d19196e9709b718ff10316d2327",
"title": "806550fb0d427d19196e9709b718ff10316d2327",
"url": "https://fuchsia.googlesource.com/fuchsia/+/806550fb0d427d19196e9709b718ff10316d2327"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "6a2070a3fd85b94711486378ad8ea403e8877b61"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@6a2070a3fd85b94711486378ad8ea403e8877b61",
"title": "6a2070a3fd85b94711486378ad8ea403e8877b61",
"url": "https://fuchsia.googlesource.com/fuchsia/+/6a2070a3fd85b94711486378ad8ea403e8877b61"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "4d2589458a58a27ccec629dfdd139973fa3983d1"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@4d2589458a58a27ccec629dfdd139973fa3983d1",
"title": "4d2589458a58a27ccec629dfdd139973fa3983d1",
"url": "https://fuchsia.googlesource.com/fuchsia/+/4d2589458a58a27ccec629dfdd139973fa3983d1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "5b508e32f8f38ba251901bf8397739422c3088fd"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@5b508e32f8f38ba251901bf8397739422c3088fd",
"title": "5b508e32f8f38ba251901bf8397739422c3088fd",
"url": "https://fuchsia.googlesource.com/fuchsia/+/5b508e32f8f38ba251901bf8397739422c3088fd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "72af4d97b5e6d65a88bf2de2f306bbc352976609"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@72af4d97b5e6d65a88bf2de2f306bbc352976609",
"title": "72af4d97b5e6d65a88bf2de2f306bbc352976609",
"url": "https://fuchsia.googlesource.com/fuchsia/+/72af4d97b5e6d65a88bf2de2f306bbc352976609"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "e6f8fad5eb8cf442e15ec1f3ef8562349327e546"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@e6f8fad5eb8cf442e15ec1f3ef8562349327e546",
"title": "e6f8fad5eb8cf442e15ec1f3ef8562349327e546",
"url": "https://fuchsia.googlesource.com/fuchsia/+/e6f8fad5eb8cf442e15ec1f3ef8562349327e546"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "b404e6ba1482172d94dfc2bea85814db5a2b089e"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@b404e6ba1482172d94dfc2bea85814db5a2b089e",
"title": "b404e6ba1482172d94dfc2bea85814db5a2b089e",
"url": "https://fuchsia.googlesource.com/fuchsia/+/b404e6ba1482172d94dfc2bea85814db5a2b089e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "33b21edab0281d35ec4eb671d879e6270f82ea93"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@33b21edab0281d35ec4eb671d879e6270f82ea93",
"title": "33b21edab0281d35ec4eb671d879e6270f82ea93",
"url": "https://fuchsia.googlesource.com/fuchsia/+/33b21edab0281d35ec4eb671d879e6270f82ea93"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "fuchsia",
"id": "33b21edab0281d35ec4eb671d879e6270f82ea93",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8889791402549864928"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[00:41:25.264] Scheduled build:
{
"id": "8724361340288946417",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "fuchsia-profile-kernel-minimal.arm64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2025-01-30T00:41:24.926625356Z",
"updateTime": "2025-01-30T00:41:24.926625356Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "fuchsia",
"id": "33b21edab0281d35ec4eb671d879e6270f82ea93",
"ref": "refs/heads/main"
}
},
"canary": true
}
[00:41:25.264] Task URL: https://cr-buildbucket.appspot.com/build/8724361340288946417
[00:41:25.264] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8889791402549864928:2:0) after 2m19s
[00:42:21.254] Received PubSub notification, asking Buildbucket for the build status
[00:42:21.277] Build status: SCHEDULED
[00:43:29.730] Received PubSub notification, asking Buildbucket for the build status
[00:43:29.768] Build status: STARTED
[00:43:44.265] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8889791402549864928:2:0)
[00:43:44.289] Build status: STARTED
[00:43:44.289] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8889791402549864928:5:0) after 3m55s
[00:47:39.316] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8889791402549864928:5:0)
[00:47:39.343] Build status: STARTED
[00:47:39.343] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8889791402549864928:6:0) after 5m9s
[00:52:48.414] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8889791402549864928:6:0)
[00:52:48.457] Build status: STARTED
[00:52:48.457] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8889791402549864928:7:0) after 7m37s
[01:00:25.573] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8889791402549864928:7:0)
[01:00:25.607] Build status: STARTED
[01:00:25.607] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8889791402549864928:8:0) after 7m39s
[01:08:04.778] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8889791402549864928:8:0)
[01:08:04.804] Build status: STARTED
[01:08:04.804] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8889791402549864928:9:0) after 9m54s
[01:17:58.923] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8889791402549864928:9:0)
[01:17:58.957] Build status: STARTED
[01:17:58.957] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8889791402549864928:10:0) after 2m31s
[01:20:30.035] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8889791402549864928:10:0)
[01:20:30.071] Build status: STARTED
[01:20:30.071] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8889791402549864928:11:0) after 7m18s
[01:27:48.099] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8889791402549864928:11:0)
[01:27:48.131] Build status: STARTED
[01:27:48.131] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8889791402549864928:12:0) after 8m20s
[01:36:08.158] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8889791402549864928:12:0)
[01:36:08.217] Build status: STARTED
[01:36:08.217] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8889791402549864928:13:0) after 8m29s
[01:44:37.237] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8889791402549864928:13:0)
[01:44:37.253] Build status: STARTED
[01:44:37.253] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8889791402549864928:14:0) after 3m1s
[01:47:38.368] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8889791402549864928:14:0)
[01:47:38.384] Build status: STARTED
[01:47:38.384] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8889791402549864928:15:0) after 3m26s
[01:51:04.456] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8889791402549864928:15:0)
[01:51:04.834] Build status: STARTED
[01:51:04.834] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8889791402549864928:16:0) after 2m23s
[01:53:27.830] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8889791402549864928:16:0)
[01:53:27.850] Build status: STARTED
[01:53:27.850] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8889791402549864928:17:0) after 1m19s
[01:54:46.867] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8889791402549864928:17:0)
[01:54:46.898] Build status: STARTED
[01:54:46.898] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8889791402549864928:18:0) after 6m24s
[02:01:11.828] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8889791402549864928:18:0)
[02:01:11.902] Build status: STARTED
[02:01:11.902] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8889791402549864928:19:0) after 6m26s
[02:07:37.928] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8889791402549864928:19:0)
[02:07:37.955] Build status: STARTED
[02:07:37.956] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8889791402549864928:20:0) after 4m43s
[02:12:20.979] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8889791402549864928:20:0)
[02:12:21.010] Build status: STARTED
[02:12:21.010] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8889791402549864928:21:0) after 5m38s
[02:14:11.588] Received PubSub notification, asking Buildbucket for the build status
[02:14:11.662] Build:
{
"id": "8724361340288946417",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "fuchsia-profile-kernel-minimal.arm64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2025-01-30T00:41:24.926625356Z",
"startTime": "2025-01-30T00:43:29.372254842Z",
"endTime": "2025-01-30T02:14:10.757699297Z",
"updateTime": "2025-01-30T02:14:10.757699297Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "fuchsia",
"id": "33b21edab0281d35ec4eb671d879e6270f82ea93",
"ref": "refs/heads/main"
}
},
"canary": true
}
[02:14:11.662] Invocation finished in 1h32m48.275101153s with status SUCCEEDED