[00:17:16.593] New invocation is queued and will start shortly
[00:17:17.679] Starting the invocation (attempt 1)
[00:17:17.702] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/39a67833e68d01e112849583605a0a5014657d98"
[00:17:17.702] Popped gitiles commit info from properties and tags
[00:17:17.702] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:17:17.702] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:17:17.702] Buildbucket request:
{
"requestId": "8848027718118859296",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-debug"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8848027718118859296",
"job": "fuchsia/global.ci-core.arm64-debug-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8eac8547d8aef8595cacf86954ad4ee211e1b4dd"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8eac8547d8aef8595cacf86954ad4ee211e1b4dd",
"title": "8eac8547d8aef8595cacf86954ad4ee211e1b4dd",
"url": "https://fuchsia.googlesource.com/integration/+/8eac8547d8aef8595cacf86954ad4ee211e1b4dd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e0bb552effe831a2b26795a46b437adadd79d14e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e0bb552effe831a2b26795a46b437adadd79d14e",
"title": "e0bb552effe831a2b26795a46b437adadd79d14e",
"url": "https://fuchsia.googlesource.com/integration/+/e0bb552effe831a2b26795a46b437adadd79d14e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4ac9fa6f195719a449ee81b952515af3c72fc9d3"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4ac9fa6f195719a449ee81b952515af3c72fc9d3",
"title": "4ac9fa6f195719a449ee81b952515af3c72fc9d3",
"url": "https://fuchsia.googlesource.com/integration/+/4ac9fa6f195719a449ee81b952515af3c72fc9d3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "cbab9683d34c5b13cea477ab7e7df0e459001461"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@cbab9683d34c5b13cea477ab7e7df0e459001461",
"title": "cbab9683d34c5b13cea477ab7e7df0e459001461",
"url": "https://fuchsia.googlesource.com/integration/+/cbab9683d34c5b13cea477ab7e7df0e459001461"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d68ebaf35ffba8603989eeb3b58281d567730c76"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d68ebaf35ffba8603989eeb3b58281d567730c76",
"title": "d68ebaf35ffba8603989eeb3b58281d567730c76",
"url": "https://fuchsia.googlesource.com/integration/+/d68ebaf35ffba8603989eeb3b58281d567730c76"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e4976c1fd0d114f72311f124c80eb77c25904069"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e4976c1fd0d114f72311f124c80eb77c25904069",
"title": "e4976c1fd0d114f72311f124c80eb77c25904069",
"url": "https://fuchsia.googlesource.com/integration/+/e4976c1fd0d114f72311f124c80eb77c25904069"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "06495f6d4aa5d50e0cbb534717ec52630c11c2b4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@06495f6d4aa5d50e0cbb534717ec52630c11c2b4",
"title": "06495f6d4aa5d50e0cbb534717ec52630c11c2b4",
"url": "https://fuchsia.googlesource.com/integration/+/06495f6d4aa5d50e0cbb534717ec52630c11c2b4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2056ed1f8c21cfdf2e4e6d4f242698a6cb7f508b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2056ed1f8c21cfdf2e4e6d4f242698a6cb7f508b",
"title": "2056ed1f8c21cfdf2e4e6d4f242698a6cb7f508b",
"url": "https://fuchsia.googlesource.com/integration/+/2056ed1f8c21cfdf2e4e6d4f242698a6cb7f508b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3cbbae373030c8365f888a29763888839a513e39"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3cbbae373030c8365f888a29763888839a513e39",
"title": "3cbbae373030c8365f888a29763888839a513e39",
"url": "https://fuchsia.googlesource.com/integration/+/3cbbae373030c8365f888a29763888839a513e39"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8985813f05855ff2eeab2587859e229143ae195e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8985813f05855ff2eeab2587859e229143ae195e",
"title": "8985813f05855ff2eeab2587859e229143ae195e",
"url": "https://fuchsia.googlesource.com/integration/+/8985813f05855ff2eeab2587859e229143ae195e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "eb734de9ecfbbc8ef469b98e0cb2c901591eb1a1"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@eb734de9ecfbbc8ef469b98e0cb2c901591eb1a1",
"title": "eb734de9ecfbbc8ef469b98e0cb2c901591eb1a1",
"url": "https://fuchsia.googlesource.com/integration/+/eb734de9ecfbbc8ef469b98e0cb2c901591eb1a1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "39a67833e68d01e112849583605a0a5014657d98"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@39a67833e68d01e112849583605a0a5014657d98",
"title": "39a67833e68d01e112849583605a0a5014657d98",
"url": "https://fuchsia.googlesource.com/integration/+/39a67833e68d01e112849583605a0a5014657d98"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "39a67833e68d01e112849583605a0a5014657d98",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8848027718118859296"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/global.ci-core.arm64-debug-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[00:17:18.221] Scheduled build:
{
"id": "8682597656229768497",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2026-05-06T00:17:17.772590287Z",
"updateTime": "2026-05-06T00:17:17.772590287Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "39a67833e68d01e112849583605a0a5014657d98",
"ref": "refs/heads/main"
}
}
}
[00:17:18.221] Task URL: https://cr-buildbucket.appspot.com/build/8682597656229768497
[00:17:18.221] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8848027718118859296:2:0) after 4m24s
[00:17:19.145] Received PubSub notification, asking Buildbucket for the build status
[00:17:19.180] Build status: SCHEDULED
[00:17:22.173] Received PubSub notification, asking Buildbucket for the build status
[00:17:22.195] Build status: STARTED
[00:21:42.389] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8848027718118859296:2:0)
[00:21:42.408] Build status: STARTED
[00:21:42.408] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8848027718118859296:5:0) after 1m42s
[00:23:24.426] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8848027718118859296:5:0)
[00:23:24.480] Build status: STARTED
[00:23:24.480] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8848027718118859296:6:0) after 1m27s
[00:24:51.772] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8848027718118859296:6:0)
[00:24:51.791] Build status: STARTED
[00:24:51.791] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8848027718118859296:7:0) after 9m19s
[00:34:10.971] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8848027718118859296:7:0)
[00:34:10.995] Build status: STARTED
[00:34:10.995] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8848027718118859296:8:0) after 7m55s
[00:42:06.144] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8848027718118859296:8:0)
[00:42:06.205] Build status: STARTED
[00:42:06.205] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8848027718118859296:9:0) after 2m36s
[00:44:42.454] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8848027718118859296:9:0)
[00:44:42.474] Build status: STARTED
[00:44:42.474] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8848027718118859296:10:0) after 1m17s
[00:45:59.609] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8848027718118859296:10:0)
[00:45:59.631] Build status: STARTED
[00:45:59.631] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8848027718118859296:11:0) after 6m11s
[00:52:10.692] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8848027718118859296:11:0)
[00:52:10.708] Build status: STARTED
[00:52:10.708] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8848027718118859296:12:0) after 1m39s
[00:53:49.726] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8848027718118859296:12:0)
[00:53:49.742] Build status: STARTED
[00:53:49.742] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8848027718118859296:13:0) after 9m5s
[01:02:54.809] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8848027718118859296:13:0)
[01:02:54.826] Build status: STARTED
[01:02:54.826] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8848027718118859296:14:0) after 4m3s
[01:06:57.893] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8848027718118859296:14:0)
[01:06:57.920] Build status: STARTED
[01:06:57.920] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8848027718118859296:15:0) after 6m17s
[01:13:14.934] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8848027718118859296:15:0)
[01:13:14.960] Build status: STARTED
[01:13:14.960] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8848027718118859296:16:0) after 5m52s
[01:19:07.083] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8848027718118859296:16:0)
[01:19:07.116] Build status: STARTED
[01:19:07.116] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-debug-e5a0ec7f:8848027718118859296:17:0) after 2m15s
[01:21:08.912] Received PubSub notification, asking Buildbucket for the build status
[01:21:08.935] Build:
{
"id": "8682597656229768497",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2026-05-06T00:17:17.772590287Z",
"startTime": "2026-05-06T00:17:21.177825654Z",
"endTime": "2026-05-06T01:21:08.003562937Z",
"updateTime": "2026-05-06T01:21:08.003562937Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "39a67833e68d01e112849583605a0a5014657d98",
"ref": "refs/heads/main"
}
}
}
[01:21:08.935] Invocation finished in 1h3m52.347661091s with status SUCCEEDED