[23:33:17.604] New invocation is queued and will start shortly
[23:33:18.809] Starting the invocation (attempt 1)
[23:33:18.840] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/2a48920352f933dc46e4323bfbd63abf39d0b44e"
[23:33:18.840] Popped gitiles commit info from properties and tags
[23:33:18.840] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:33:18.840] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:33:18.840] Buildbucket request:
{
"requestId": "8908096274029910000",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-asan"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8908096274029910000",
"job": "fuchsia/core.arm64-asan-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f0685ce6fd427db8cd2a3004a52e33045a751b3b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f0685ce6fd427db8cd2a3004a52e33045a751b3b",
"title": "f0685ce6fd427db8cd2a3004a52e33045a751b3b",
"url": "https://fuchsia.googlesource.com/integration/+/f0685ce6fd427db8cd2a3004a52e33045a751b3b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f088d08ceb3bd12dbf7ea91176c65fea142e43ff"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f088d08ceb3bd12dbf7ea91176c65fea142e43ff",
"title": "f088d08ceb3bd12dbf7ea91176c65fea142e43ff",
"url": "https://fuchsia.googlesource.com/integration/+/f088d08ceb3bd12dbf7ea91176c65fea142e43ff"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "72f4beaea167d46752d50759ee818c45e8fdcd47"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@72f4beaea167d46752d50759ee818c45e8fdcd47",
"title": "72f4beaea167d46752d50759ee818c45e8fdcd47",
"url": "https://fuchsia.googlesource.com/integration/+/72f4beaea167d46752d50759ee818c45e8fdcd47"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "de152dfdc5e3058dc51b04bcbcbcfe6fab5fe6d1"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@de152dfdc5e3058dc51b04bcbcbcfe6fab5fe6d1",
"title": "de152dfdc5e3058dc51b04bcbcbcfe6fab5fe6d1",
"url": "https://fuchsia.googlesource.com/integration/+/de152dfdc5e3058dc51b04bcbcbcfe6fab5fe6d1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "56eab623ee53c6699a5d1295827cdcab2fdbc12c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@56eab623ee53c6699a5d1295827cdcab2fdbc12c",
"title": "56eab623ee53c6699a5d1295827cdcab2fdbc12c",
"url": "https://fuchsia.googlesource.com/integration/+/56eab623ee53c6699a5d1295827cdcab2fdbc12c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f36be754334883e22a439278ab4f8d71e3db6043"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f36be754334883e22a439278ab4f8d71e3db6043",
"title": "f36be754334883e22a439278ab4f8d71e3db6043",
"url": "https://fuchsia.googlesource.com/integration/+/f36be754334883e22a439278ab4f8d71e3db6043"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c394b751094fa72107156db9a730837a7ff727b5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c394b751094fa72107156db9a730837a7ff727b5",
"title": "c394b751094fa72107156db9a730837a7ff727b5",
"url": "https://fuchsia.googlesource.com/integration/+/c394b751094fa72107156db9a730837a7ff727b5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b098f55ca8c94e19887e5285364f92af1f3611b4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b098f55ca8c94e19887e5285364f92af1f3611b4",
"title": "b098f55ca8c94e19887e5285364f92af1f3611b4",
"url": "https://fuchsia.googlesource.com/integration/+/b098f55ca8c94e19887e5285364f92af1f3611b4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0f24e2628678a5ca013202cc5b623cb1220686f7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0f24e2628678a5ca013202cc5b623cb1220686f7",
"title": "0f24e2628678a5ca013202cc5b623cb1220686f7",
"url": "https://fuchsia.googlesource.com/integration/+/0f24e2628678a5ca013202cc5b623cb1220686f7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2b92328213187fffe0263d976808615a2140cbc6"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2b92328213187fffe0263d976808615a2140cbc6",
"title": "2b92328213187fffe0263d976808615a2140cbc6",
"url": "https://fuchsia.googlesource.com/integration/+/2b92328213187fffe0263d976808615a2140cbc6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "64eb9c564654103c9eb671401e28c85718876bd7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@64eb9c564654103c9eb671401e28c85718876bd7",
"title": "64eb9c564654103c9eb671401e28c85718876bd7",
"url": "https://fuchsia.googlesource.com/integration/+/64eb9c564654103c9eb671401e28c85718876bd7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e90b86a7c8499ed044f1e5acda4e8b26e46361cd"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e90b86a7c8499ed044f1e5acda4e8b26e46361cd",
"title": "e90b86a7c8499ed044f1e5acda4e8b26e46361cd",
"url": "https://fuchsia.googlesource.com/integration/+/e90b86a7c8499ed044f1e5acda4e8b26e46361cd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2a48920352f933dc46e4323bfbd63abf39d0b44e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2a48920352f933dc46e4323bfbd63abf39d0b44e",
"title": "2a48920352f933dc46e4323bfbd63abf39d0b44e",
"url": "https://fuchsia.googlesource.com/integration/+/2a48920352f933dc46e4323bfbd63abf39d0b44e"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "2a48920352f933dc46e4323bfbd63abf39d0b44e",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8908096274029910000"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/core.arm64-asan-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[23:33:19.674] Scheduled build:
{
"id": "8742666211920335937",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-asan"
},
"createdBy": "project:fuchsia",
"createTime": "2024-07-11T23:33:18.986266007Z",
"updateTime": "2024-07-11T23:33:18.986266007Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "2a48920352f933dc46e4323bfbd63abf39d0b44e",
"ref": "refs/heads/main"
}
}
}
[23:33:19.674] Task URL: https://cr-buildbucket.appspot.com/build/8742666211920335937
[23:33:19.674] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8908096274029910000:2:0) after 7m39s
[23:33:20.504] Received PubSub notification, asking Buildbucket for the build status
[23:33:20.602] Build status: SCHEDULED
[23:33:35.777] Received PubSub notification, asking Buildbucket for the build status
[23:33:35.841] Build status: STARTED
[23:40:58.689] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8908096274029910000:2:0)
[23:40:58.725] Build status: STARTED
[23:40:58.725] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8908096274029910000:5:0) after 1m54s
[23:42:52.708] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8908096274029910000:5:0)
[23:42:52.727] Build status: STARTED
[23:42:52.727] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8908096274029910000:6:0) after 2m32s
[23:45:24.843] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8908096274029910000:6:0)
[23:45:24.913] Build status: STARTED
[23:45:24.913] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8908096274029910000:7:0) after 2m33s
[23:47:57.978] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8908096274029910000:7:0)
[23:47:58.000] Build status: STARTED
[23:47:58.000] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8908096274029910000:8:0) after 8m50s
[23:56:48.034] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8908096274029910000:8:0)
[23:56:48.055] Build status: STARTED
[23:56:48.055] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8908096274029910000:9:0) after 9m13s
[00:06:01.159] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8908096274029910000:9:0)
[00:06:01.177] Build status: STARTED
[00:06:01.177] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8908096274029910000:10:0) after 8m43s
[00:14:44.194] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8908096274029910000:10:0)
[00:14:44.210] Build status: STARTED
[00:14:44.210] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8908096274029910000:11:0) after 8m11s
[00:22:55.230] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8908096274029910000:11:0)
[00:22:55.252] Build status: STARTED
[00:22:55.252] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8908096274029910000:12:0) after 6m35s
[00:29:30.279] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8908096274029910000:12:0)
[00:29:30.459] Build status: STARTED
[00:29:30.459] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8908096274029910000:13:0) after 2m7s
[00:31:37.535] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8908096274029910000:13:0)
[00:31:37.556] Build status: STARTED
[00:31:37.556] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8908096274029910000:14:0) after 4m22s
[00:35:59.616] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8908096274029910000:14:0)
[00:35:59.635] Build status: STARTED
[00:35:59.635] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8908096274029910000:15:0) after 8m38s
[00:44:37.657] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8908096274029910000:15:0)
[00:44:37.672] Build status: STARTED
[00:44:37.672] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8908096274029910000:16:0) after 2m22s
[00:46:59.743] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8908096274029910000:16:0)
[00:46:59.762] Build status: STARTED
[00:46:59.762] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8908096274029910000:17:0) after 3m12s
[00:50:11.792] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8908096274029910000:17:0)
[00:50:11.814] Build status: STARTED
[00:50:11.814] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8908096274029910000:18:0) after 5m16s
[00:55:28.029] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8908096274029910000:18:0)
[00:55:28.071] Build status: STARTED
[00:55:28.071] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8908096274029910000:19:0) after 6m6s
[00:55:57.583] Received PubSub notification, asking Buildbucket for the build status
[00:55:57.605] Build:
{
"id": "8742666211920335937",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-asan"
},
"createdBy": "project:fuchsia",
"createTime": "2024-07-11T23:33:18.986266007Z",
"startTime": "2024-07-11T23:33:35.192089134Z",
"endTime": "2024-07-12T00:55:57.207248910Z",
"updateTime": "2024-07-12T00:55:57.207248910Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "2a48920352f933dc46e4323bfbd63abf39d0b44e",
"ref": "refs/heads/main"
}
}
}
[00:55:57.605] Invocation finished in 1h22m40.013920557s with status SUCCEEDED