[01:47:26.316] New invocation is queued and will start shortly
[01:47:27.461] Starting the invocation (attempt 1)
[01:47:27.490] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/fuchsia/+/7b44b63b0b1b74c593753a01e099d086ab435a79"
[01:47:27.490] Popped gitiles commit info from properties and tags
[01:47:27.490] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:47:27.490] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:47:27.491] Buildbucket request:
{
"requestId": "8887975307803948272",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "fuchsia-profile-kernel-minimal.arm64-release"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8887975307803948272",
"job": "fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "0dff0e536c2e85ecbf63d1bfaa5cd38b4195ba4a"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@0dff0e536c2e85ecbf63d1bfaa5cd38b4195ba4a",
"title": "0dff0e536c2e85ecbf63d1bfaa5cd38b4195ba4a",
"url": "https://fuchsia.googlesource.com/fuchsia/+/0dff0e536c2e85ecbf63d1bfaa5cd38b4195ba4a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "2b4bb26f975367e64b99600ecd2ef539ebbf28e2"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@2b4bb26f975367e64b99600ecd2ef539ebbf28e2",
"title": "2b4bb26f975367e64b99600ecd2ef539ebbf28e2",
"url": "https://fuchsia.googlesource.com/fuchsia/+/2b4bb26f975367e64b99600ecd2ef539ebbf28e2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "c97eac03cdee5e64ee6b48f4f72e1291010c7328"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@c97eac03cdee5e64ee6b48f4f72e1291010c7328",
"title": "c97eac03cdee5e64ee6b48f4f72e1291010c7328",
"url": "https://fuchsia.googlesource.com/fuchsia/+/c97eac03cdee5e64ee6b48f4f72e1291010c7328"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "7c54e826e6c40aea3bc65b932cc9aeabae12e44c"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@7c54e826e6c40aea3bc65b932cc9aeabae12e44c",
"title": "7c54e826e6c40aea3bc65b932cc9aeabae12e44c",
"url": "https://fuchsia.googlesource.com/fuchsia/+/7c54e826e6c40aea3bc65b932cc9aeabae12e44c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "94fd93ce9fdc0ded0528a62ce5ca86b8e7c44381"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@94fd93ce9fdc0ded0528a62ce5ca86b8e7c44381",
"title": "94fd93ce9fdc0ded0528a62ce5ca86b8e7c44381",
"url": "https://fuchsia.googlesource.com/fuchsia/+/94fd93ce9fdc0ded0528a62ce5ca86b8e7c44381"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "71b5c655286a03a136249583ba94390dfa8ac1c0"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@71b5c655286a03a136249583ba94390dfa8ac1c0",
"title": "71b5c655286a03a136249583ba94390dfa8ac1c0",
"url": "https://fuchsia.googlesource.com/fuchsia/+/71b5c655286a03a136249583ba94390dfa8ac1c0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "9849d1b3c8d3e483c7e55621a3b03f19fb598d8e"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@9849d1b3c8d3e483c7e55621a3b03f19fb598d8e",
"title": "9849d1b3c8d3e483c7e55621a3b03f19fb598d8e",
"url": "https://fuchsia.googlesource.com/fuchsia/+/9849d1b3c8d3e483c7e55621a3b03f19fb598d8e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "3f10b17370240bcc3e124eaa2d1d06c0aad6a613"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@3f10b17370240bcc3e124eaa2d1d06c0aad6a613",
"title": "3f10b17370240bcc3e124eaa2d1d06c0aad6a613",
"url": "https://fuchsia.googlesource.com/fuchsia/+/3f10b17370240bcc3e124eaa2d1d06c0aad6a613"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "9202e0f7bc03d54d6998945b82793292e73d7b15"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@9202e0f7bc03d54d6998945b82793292e73d7b15",
"title": "9202e0f7bc03d54d6998945b82793292e73d7b15",
"url": "https://fuchsia.googlesource.com/fuchsia/+/9202e0f7bc03d54d6998945b82793292e73d7b15"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "7b44b63b0b1b74c593753a01e099d086ab435a79"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@7b44b63b0b1b74c593753a01e099d086ab435a79",
"title": "7b44b63b0b1b74c593753a01e099d086ab435a79",
"url": "https://fuchsia.googlesource.com/fuchsia/+/7b44b63b0b1b74c593753a01e099d086ab435a79"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "fuchsia",
"id": "7b44b63b0b1b74c593753a01e099d086ab435a79",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8887975307803948272"
},
{
"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"
}
}
[01:47:28.199] Scheduled build:
{
"id": "8722545245793509313",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "fuchsia-profile-kernel-minimal.arm64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2025-02-19T01:47:27.603638711Z",
"updateTime": "2025-02-19T01:47:27.603638711Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "fuchsia",
"id": "7b44b63b0b1b74c593753a01e099d086ab435a79",
"ref": "refs/heads/main"
}
}
}
[01:47:28.199] Task URL: https://cr-buildbucket.appspot.com/build/8722545245793509313
[01:47:28.199] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8887975307803948272:2:0) after 9m4s
[01:47:29.094] Received PubSub notification, asking Buildbucket for the build status
[01:47:29.118] Build status: SCHEDULED
[01:47:32.459] Received PubSub notification, asking Buildbucket for the build status
[01:47:32.476] Build status: STARTED
[01:56:32.240] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8887975307803948272:2:0)
[01:56:32.264] Build status: STARTED
[01:56:32.264] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8887975307803948272:5:0) after 4m58s
[02:01:30.369] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8887975307803948272:5:0)
[02:01:30.391] Build status: STARTED
[02:01:30.391] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8887975307803948272:6:0) after 5m43s
[02:07:13.415] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8887975307803948272:6:0)
[02:07:13.443] Build status: STARTED
[02:07:13.443] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8887975307803948272:7:0) after 8m40s
[02:15:53.424] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8887975307803948272:7:0)
[02:15:53.443] Build status: STARTED
[02:15:53.443] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8887975307803948272:8:0) after 1m10s
[02:17:03.566] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8887975307803948272:8:0)
[02:17:03.587] Build status: STARTED
[02:17:03.587] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8887975307803948272:9:0) after 6m12s
[02:23:15.610] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8887975307803948272:9:0)
[02:23:15.629] Build status: STARTED
[02:23:15.629] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8887975307803948272:10:0) after 4m19s
[02:27:34.644] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8887975307803948272:10:0)
[02:27:34.668] Build status: STARTED
[02:27:34.668] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8887975307803948272:11:0) after 6m13s
[02:33:47.688] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8887975307803948272:11:0)
[02:33:47.703] Build status: STARTED
[02:33:47.703] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8887975307803948272:12:0) after 6m43s
[02:40:30.720] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8887975307803948272:12:0)
[02:40:30.752] Build status: STARTED
[02:40:30.752] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8887975307803948272:13:0) after 4m42s
[02:45:12.773] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8887975307803948272:13:0)
[02:45:12.825] Build status: STARTED
[02:45:12.825] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8887975307803948272:14:0) after 9m35s
[02:54:47.898] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8887975307803948272:14:0)
[02:54:47.926] Build status: STARTED
[02:54:47.926] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8887975307803948272:15:0) after 2m43s
[02:57:30.987] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8887975307803948272:15:0)
[02:57:31.005] Build status: STARTED
[02:57:31.005] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8887975307803948272:16:0) after 7m20s
[03:04:51.019] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8887975307803948272:16:0)
[03:04:51.047] Build status: STARTED
[03:04:51.047] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-kernel-minimal.arm64-release-af244ac6:8887975307803948272:17:0) after 5m4s
[03:06:36.251] Received PubSub notification, asking Buildbucket for the build status
[03:06:36.267] Build:
{
"id": "8722545245793509313",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "fuchsia-profile-kernel-minimal.arm64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2025-02-19T01:47:27.603638711Z",
"startTime": "2025-02-19T01:47:32.287134335Z",
"endTime": "2025-02-19T03:06:35.967884035Z",
"updateTime": "2025-02-19T03:06:35.967884035Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "fuchsia",
"id": "7b44b63b0b1b74c593753a01e099d086ab435a79",
"ref": "refs/heads/main"
}
}
}
[03:06:36.267] Invocation finished in 1h19m9.965448237s with status SUCCEEDED