[17:55:10.985] New invocation is queued and will start shortly
[17:55:12.029] Starting the invocation (attempt 1)
[17:55:12.053] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/706d56a44c5cc3949cccba4961edcf50b4843e8a"
[17:55:12.053] Popped gitiles commit info from properties and tags
[17:55:12.053] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:55:12.062] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:55:12.062] Buildbucket request:
{
"requestId": "8877767562338524528",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-asan"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8877767562338524528",
"job": "fuchsia/global.ci-core.arm64-asan-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "54166ad590abc129febef0b2602f20171c754be9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@54166ad590abc129febef0b2602f20171c754be9",
"title": "54166ad590abc129febef0b2602f20171c754be9",
"url": "https://fuchsia.googlesource.com/integration/+/54166ad590abc129febef0b2602f20171c754be9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "db250e28b17cba8456d7cc5e29742535c3137454"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@db250e28b17cba8456d7cc5e29742535c3137454",
"title": "db250e28b17cba8456d7cc5e29742535c3137454",
"url": "https://fuchsia.googlesource.com/integration/+/db250e28b17cba8456d7cc5e29742535c3137454"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5e263d69ffc28de58df6c5dc58998fd6d05ac553"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5e263d69ffc28de58df6c5dc58998fd6d05ac553",
"title": "5e263d69ffc28de58df6c5dc58998fd6d05ac553",
"url": "https://fuchsia.googlesource.com/integration/+/5e263d69ffc28de58df6c5dc58998fd6d05ac553"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "492720fb652d9fe348121ec5109d71a8db39830a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@492720fb652d9fe348121ec5109d71a8db39830a",
"title": "492720fb652d9fe348121ec5109d71a8db39830a",
"url": "https://fuchsia.googlesource.com/integration/+/492720fb652d9fe348121ec5109d71a8db39830a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "daa641f5b23e67c06d96f8fd4c4d5a0344d0cdf9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@daa641f5b23e67c06d96f8fd4c4d5a0344d0cdf9",
"title": "daa641f5b23e67c06d96f8fd4c4d5a0344d0cdf9",
"url": "https://fuchsia.googlesource.com/integration/+/daa641f5b23e67c06d96f8fd4c4d5a0344d0cdf9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "06f398ef3676f665b3a9b3ebf979ef34811daa3e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@06f398ef3676f665b3a9b3ebf979ef34811daa3e",
"title": "06f398ef3676f665b3a9b3ebf979ef34811daa3e",
"url": "https://fuchsia.googlesource.com/integration/+/06f398ef3676f665b3a9b3ebf979ef34811daa3e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "37cf69a4ed9f0ba51256b2e75a3d2efeabbdc26d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@37cf69a4ed9f0ba51256b2e75a3d2efeabbdc26d",
"title": "37cf69a4ed9f0ba51256b2e75a3d2efeabbdc26d",
"url": "https://fuchsia.googlesource.com/integration/+/37cf69a4ed9f0ba51256b2e75a3d2efeabbdc26d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0bad8de996674754c8ba3b2124849301fe80808f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0bad8de996674754c8ba3b2124849301fe80808f",
"title": "0bad8de996674754c8ba3b2124849301fe80808f",
"url": "https://fuchsia.googlesource.com/integration/+/0bad8de996674754c8ba3b2124849301fe80808f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "db87d46f4d718e9d1f88703c49b7cd611be11ce4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@db87d46f4d718e9d1f88703c49b7cd611be11ce4",
"title": "db87d46f4d718e9d1f88703c49b7cd611be11ce4",
"url": "https://fuchsia.googlesource.com/integration/+/db87d46f4d718e9d1f88703c49b7cd611be11ce4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4dcd93a310b3b419db55fac8af85e3611f34d545"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4dcd93a310b3b419db55fac8af85e3611f34d545",
"title": "4dcd93a310b3b419db55fac8af85e3611f34d545",
"url": "https://fuchsia.googlesource.com/integration/+/4dcd93a310b3b419db55fac8af85e3611f34d545"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "706d56a44c5cc3949cccba4961edcf50b4843e8a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@706d56a44c5cc3949cccba4961edcf50b4843e8a",
"title": "706d56a44c5cc3949cccba4961edcf50b4843e8a",
"url": "https://fuchsia.googlesource.com/integration/+/706d56a44c5cc3949cccba4961edcf50b4843e8a"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "706d56a44c5cc3949cccba4961edcf50b4843e8a",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8877767562338524528"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/global.ci-core.arm64-asan-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[17:55:12.525] Scheduled build:
{
"id": "8712337500486280529",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-asan"
},
"createdBy": "project:fuchsia",
"createTime": "2025-06-11T17:55:12.131331490Z",
"updateTime": "2025-06-11T17:55:12.131331490Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "706d56a44c5cc3949cccba4961edcf50b4843e8a",
"ref": "refs/heads/main"
}
}
}
[17:55:12.525] Task URL: https://cr-buildbucket.appspot.com/build/8712337500486280529
[17:55:12.525] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-asan-e5a0ec7f:8877767562338524528:2:0) after 1m31s
[17:55:12.743] Received PubSub notification, asking Buildbucket for the build status
[17:55:12.775] Build status: SCHEDULED
[17:56:43.635] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-asan-e5a0ec7f:8877767562338524528:2:0)
[17:56:43.659] Build status: SCHEDULED
[17:56:43.659] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-asan-e5a0ec7f:8877767562338524528:4:0) after 8m37s
[17:56:57.713] Received PubSub notification, asking Buildbucket for the build status
[17:56:57.738] Build status: STARTED
[18:05:20.710] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-asan-e5a0ec7f:8877767562338524528:4:0)
[18:05:20.741] Build status: STARTED
[18:05:20.741] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-asan-e5a0ec7f:8877767562338524528:6:0) after 5m43s
[18:11:03.746] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-asan-e5a0ec7f:8877767562338524528:6:0)
[18:11:03.829] Build status: STARTED
[18:11:03.829] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-asan-e5a0ec7f:8877767562338524528:7:0) after 3m22s
[18:14:25.909] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-asan-e5a0ec7f:8877767562338524528:7:0)
[18:14:25.934] Build status: STARTED
[18:14:25.934] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-asan-e5a0ec7f:8877767562338524528:8:0) after 2m56s
[18:17:21.978] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-asan-e5a0ec7f:8877767562338524528:8:0)
[18:17:22.010] Build status: STARTED
[18:17:22.010] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-asan-e5a0ec7f:8877767562338524528:9:0) after 6m26s
[18:23:48.066] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-asan-e5a0ec7f:8877767562338524528:9:0)
[18:23:48.175] Build status: STARTED
[18:23:48.175] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-asan-e5a0ec7f:8877767562338524528:10:0) after 6m50s
[18:30:38.191] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-asan-e5a0ec7f:8877767562338524528:10:0)
[18:30:38.282] Build status: STARTED
[18:30:38.282] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-asan-e5a0ec7f:8877767562338524528:11:0) after 8m51s
[18:39:29.379] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-asan-e5a0ec7f:8877767562338524528:11:0)
[18:39:29.405] Build status: STARTED
[18:39:29.405] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-asan-e5a0ec7f:8877767562338524528:12:0) after 6m52s
[18:46:21.436] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-asan-e5a0ec7f:8877767562338524528:12:0)
[18:46:21.454] Build status: STARTED
[18:46:21.454] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-asan-e5a0ec7f:8877767562338524528:13:0) after 8m42s
[18:55:03.495] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-asan-e5a0ec7f:8877767562338524528:13:0)
[18:55:03.509] Build status: STARTED
[18:55:03.509] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-asan-e5a0ec7f:8877767562338524528:14:0) after 4m41s
[18:59:44.587] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-asan-e5a0ec7f:8877767562338524528:14:0)
[18:59:44.635] Build status: STARTED
[18:59:44.635] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-asan-e5a0ec7f:8877767562338524528:15:0) after 5m42s
[19:05:26.684] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-asan-e5a0ec7f:8877767562338524528:15:0)
[19:05:26.704] Build status: STARTED
[19:05:26.704] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-asan-e5a0ec7f:8877767562338524528:16:0) after 2m27s
[19:07:53.736] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-asan-e5a0ec7f:8877767562338524528:16:0)
[19:07:53.758] Build status: STARTED
[19:07:53.758] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-asan-e5a0ec7f:8877767562338524528:17:0) after 3m7s
[19:11:00.833] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-asan-e5a0ec7f:8877767562338524528:17:0)
[19:11:00.855] Build status: STARTED
[19:11:00.855] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-asan-e5a0ec7f:8877767562338524528:18:0) after 5m13s
[19:16:14.132] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-asan-e5a0ec7f:8877767562338524528:18:0)
[19:16:14.185] Build status: STARTED
[19:16:14.185] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-asan-e5a0ec7f:8877767562338524528:19:0) after 5m42s
[19:21:56.218] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-asan-e5a0ec7f:8877767562338524528:19:0)
[19:21:56.234] Build status: STARTED
[19:21:56.234] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-asan-e5a0ec7f:8877767562338524528:20:0) after 4m19s
[19:24:12.457] Received PubSub notification, asking Buildbucket for the build status
[19:24:12.475] Build:
{
"id": "8712337500486280529",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-asan"
},
"createdBy": "project:fuchsia",
"createTime": "2025-06-11T17:55:12.131331490Z",
"startTime": "2025-06-11T17:56:57.448325819Z",
"endTime": "2025-06-11T19:24:11.487939506Z",
"updateTime": "2025-06-11T19:24:11.487939506Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "706d56a44c5cc3949cccba4961edcf50b4843e8a",
"ref": "refs/heads/main"
}
}
}
[19:24:12.475] Invocation finished in 1h29m1.494099986s with status SUCCEEDED