[00:19:03.173] New invocation is queued and will start shortly
[00:19:04.221] Starting the invocation (attempt 1)
[00:19:04.247] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/e6b4cedf2407986c92de793066ab2a13c6a878c4"
[00:19:04.247] Popped gitiles commit info from properties and tags
[00:19:04.247] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:19:04.247] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:19:04.248] Buildbucket request:
{
"requestId": "8906462649693978608",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-lto-no_rbe-build_only"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8906462649693978608",
"job": "fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "09446fa2c10268d111511e054341c1d7bc37e051"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@09446fa2c10268d111511e054341c1d7bc37e051",
"title": "09446fa2c10268d111511e054341c1d7bc37e051",
"url": "https://fuchsia.googlesource.com/integration/+/09446fa2c10268d111511e054341c1d7bc37e051"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "01e9d330d9287edf6638e30ab8f7b8b98cafeefa"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@01e9d330d9287edf6638e30ab8f7b8b98cafeefa",
"title": "01e9d330d9287edf6638e30ab8f7b8b98cafeefa",
"url": "https://fuchsia.googlesource.com/integration/+/01e9d330d9287edf6638e30ab8f7b8b98cafeefa"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "aabc1039a60830d649c47d375cbf99c77f19eb2f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@aabc1039a60830d649c47d375cbf99c77f19eb2f",
"title": "aabc1039a60830d649c47d375cbf99c77f19eb2f",
"url": "https://fuchsia.googlesource.com/integration/+/aabc1039a60830d649c47d375cbf99c77f19eb2f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9efbc2e117b3023b51d19bc61d7c6751ac6df4b5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9efbc2e117b3023b51d19bc61d7c6751ac6df4b5",
"title": "9efbc2e117b3023b51d19bc61d7c6751ac6df4b5",
"url": "https://fuchsia.googlesource.com/integration/+/9efbc2e117b3023b51d19bc61d7c6751ac6df4b5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "aa042af82d6c6df7df01f0d45c952fb7efcfc7fb"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@aa042af82d6c6df7df01f0d45c952fb7efcfc7fb",
"title": "aa042af82d6c6df7df01f0d45c952fb7efcfc7fb",
"url": "https://fuchsia.googlesource.com/integration/+/aa042af82d6c6df7df01f0d45c952fb7efcfc7fb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ff75a332f38575a8ddce030599560b27b8143bdd"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ff75a332f38575a8ddce030599560b27b8143bdd",
"title": "ff75a332f38575a8ddce030599560b27b8143bdd",
"url": "https://fuchsia.googlesource.com/integration/+/ff75a332f38575a8ddce030599560b27b8143bdd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9192fac10b943f8b73c74f3ebe2b4cd74f3767a9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9192fac10b943f8b73c74f3ebe2b4cd74f3767a9",
"title": "9192fac10b943f8b73c74f3ebe2b4cd74f3767a9",
"url": "https://fuchsia.googlesource.com/integration/+/9192fac10b943f8b73c74f3ebe2b4cd74f3767a9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "eb437a39a43a5ee4c25b6d38ed2394ea79c5a6df"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@eb437a39a43a5ee4c25b6d38ed2394ea79c5a6df",
"title": "eb437a39a43a5ee4c25b6d38ed2394ea79c5a6df",
"url": "https://fuchsia.googlesource.com/integration/+/eb437a39a43a5ee4c25b6d38ed2394ea79c5a6df"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "70084aa939aeaab99dfcb2724abcc980751e6d02"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@70084aa939aeaab99dfcb2724abcc980751e6d02",
"title": "70084aa939aeaab99dfcb2724abcc980751e6d02",
"url": "https://fuchsia.googlesource.com/integration/+/70084aa939aeaab99dfcb2724abcc980751e6d02"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "82cf0acc6bc56f87dd541adbf21969047fa8baab"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@82cf0acc6bc56f87dd541adbf21969047fa8baab",
"title": "82cf0acc6bc56f87dd541adbf21969047fa8baab",
"url": "https://fuchsia.googlesource.com/integration/+/82cf0acc6bc56f87dd541adbf21969047fa8baab"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "617744a4e46cd33e4a6ac068fa878ed71c9a1da2"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@617744a4e46cd33e4a6ac068fa878ed71c9a1da2",
"title": "617744a4e46cd33e4a6ac068fa878ed71c9a1da2",
"url": "https://fuchsia.googlesource.com/integration/+/617744a4e46cd33e4a6ac068fa878ed71c9a1da2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c529dffa6ce49ed64d5f6c9291c4623638da4cc4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c529dffa6ce49ed64d5f6c9291c4623638da4cc4",
"title": "c529dffa6ce49ed64d5f6c9291c4623638da4cc4",
"url": "https://fuchsia.googlesource.com/integration/+/c529dffa6ce49ed64d5f6c9291c4623638da4cc4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9d6c17be9ae2fdf5de008527f5894405bc35a316"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9d6c17be9ae2fdf5de008527f5894405bc35a316",
"title": "9d6c17be9ae2fdf5de008527f5894405bc35a316",
"url": "https://fuchsia.googlesource.com/integration/+/9d6c17be9ae2fdf5de008527f5894405bc35a316"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8a023e22d7fdfe08c2fe062eabb470589a5b67da"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8a023e22d7fdfe08c2fe062eabb470589a5b67da",
"title": "8a023e22d7fdfe08c2fe062eabb470589a5b67da",
"url": "https://fuchsia.googlesource.com/integration/+/8a023e22d7fdfe08c2fe062eabb470589a5b67da"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e6b4cedf2407986c92de793066ab2a13c6a878c4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e6b4cedf2407986c92de793066ab2a13c6a878c4",
"title": "e6b4cedf2407986c92de793066ab2a13c6a878c4",
"url": "https://fuchsia.googlesource.com/integration/+/e6b4cedf2407986c92de793066ab2a13c6a878c4"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "e6b4cedf2407986c92de793066ab2a13c6a878c4",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8906462649693978608"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[00:19:04.701] Scheduled build:
{
"id": "8741032587852858017",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-lto-no_rbe-build_only"
},
"createdBy": "project:fuchsia",
"createTime": "2024-07-30T00:19:04.302694083Z",
"updateTime": "2024-07-30T00:19:04.302694083Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "e6b4cedf2407986c92de793066ab2a13c6a878c4",
"ref": "refs/heads/main"
}
}
}
[00:19:04.701] Task URL: https://cr-buildbucket.appspot.com/build/8741032587852858017
[00:19:04.701] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:2:0) after 8m31s
[00:19:05.668] Received PubSub notification, asking Buildbucket for the build status
[00:19:05.717] Build status: SCHEDULED
[00:19:09.769] Received PubSub notification, asking Buildbucket for the build status
[00:19:09.792] Build status: STARTED
[00:27:35.727] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:2:0)
[00:27:35.745] Build status: STARTED
[00:27:35.745] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:5:0) after 9m53s
[00:37:28.765] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:5:0)
[00:37:28.813] Build status: STARTED
[00:37:28.813] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:6:0) after 1m15s
[00:38:43.882] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:6:0)
[00:38:43.906] Build status: STARTED
[00:38:43.906] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:7:0) after 5m24s
[00:44:07.936] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:7:0)
[00:44:07.958] Build status: STARTED
[00:44:07.958] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:8:0) after 1m12s
[00:45:20.067] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:8:0)
[00:45:20.161] Build status: STARTED
[00:45:20.161] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:9:0) after 5m45s
[00:51:05.218] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:9:0)
[00:51:05.242] Build status: STARTED
[00:51:05.242] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:10:0) after 2m11s
[00:53:16.269] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:10:0)
[00:53:16.294] Build status: STARTED
[00:53:16.294] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:11:0) after 6m57s
[01:00:13.341] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:11:0)
[01:00:13.431] Build status: STARTED
[01:00:13.431] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:12:0) after 2m37s
[01:02:50.500] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:12:0)
[01:02:50.520] Build status: STARTED
[01:02:50.521] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:13:0) after 5m21s
[01:08:11.555] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:13:0)
[01:08:11.625] Build status: STARTED
[01:08:11.625] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:14:0) after 2m36s
[01:10:47.641] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:14:0)
[01:10:47.659] Build status: STARTED
[01:10:47.659] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:15:0) after 1m16s
[01:12:03.676] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:15:0)
[01:12:03.693] Build status: STARTED
[01:12:03.693] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:16:0) after 6m0s
[01:18:03.833] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:16:0)
[01:18:03.919] Build status: STARTED
[01:18:03.919] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:17:0) after 6m19s
[01:24:22.927] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:17:0)
[01:24:22.945] Build status: STARTED
[01:24:22.945] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:18:0) after 4m5s
[01:28:27.920] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:18:0)
[01:28:27.946] Build status: STARTED
[01:28:27.946] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:19:0) after 3m42s
[01:32:09.964] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:19:0)
[01:32:09.979] Build status: STARTED
[01:32:09.979] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:20:0) after 2m53s
[01:35:03.009] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:20:0)
[01:35:03.037] Build status: STARTED
[01:35:03.037] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:21:0) after 3m46s
[01:38:49.056] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:21:0)
[01:38:49.072] Build status: STARTED
[01:38:49.072] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:22:0) after 1m6s
[01:39:55.149] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:22:0)
[01:39:55.166] Build status: STARTED
[01:39:55.166] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:23:0) after 8m18s
[01:48:13.218] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:23:0)
[01:48:13.235] Build status: STARTED
[01:48:13.235] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:24:0) after 5m54s
[01:54:07.310] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:24:0)
[01:54:07.328] Build status: STARTED
[01:54:07.328] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:25:0) after 8m18s
[02:02:25.362] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:25:0)
[02:02:25.417] Build status: STARTED
[02:02:25.417] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:26:0) after 5m1s
[02:07:26.487] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:26:0)
[02:07:26.513] Build status: STARTED
[02:07:26.513] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:27:0) after 7m35s
[02:15:01.534] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:27:0)
[02:15:01.558] Build status: STARTED
[02:15:01.558] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:28:0) after 5m38s
[02:20:39.579] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:28:0)
[02:20:39.595] Build status: STARTED
[02:20:39.595] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:29:0) after 5m16s
[02:25:55.621] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:29:0)
[02:25:55.639] Build status: STARTED
[02:25:55.640] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-lto-no_rbe-build_only-e5a0ec7f:8906462649693978608:30:0) after 7m51s
[02:27:31.533] Received PubSub notification, asking Buildbucket for the build status
[02:27:31.564] Build:
{
"id": "8741032587852858017",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-lto-no_rbe-build_only"
},
"createdBy": "project:fuchsia",
"createTime": "2024-07-30T00:19:04.302694083Z",
"startTime": "2024-07-30T00:19:09.453928659Z",
"endTime": "2024-07-30T02:27:31.208926325Z",
"updateTime": "2024-07-30T02:27:31.208926325Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "e6b4cedf2407986c92de793066ab2a13c6a878c4",
"ref": "refs/heads/main"
}
}
}
[02:27:31.564] Invocation finished in 2h8m28.400343106s with status SUCCEEDED