[20:49:21.866] New invocation is queued and will start shortly
[20:49:22.985] Starting the invocation (attempt 1)
[20:49:23.047] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/71970121c1a4c1a266861dd3587985cdbe0e763e"
[20:49:23.047] Popped gitiles commit info from properties and tags
[20:49:23.047] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:49:23.047] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:49:23.048] Buildbucket request:
{
"requestId": "8912545838899581008",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "minimal.riscv64-lto"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8912545838899581008",
"job": "fuchsia/minimal.riscv64-lto-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "fd5e5c8d8dbc359a4459772142cf7346e427da20"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@fd5e5c8d8dbc359a4459772142cf7346e427da20",
"title": "fd5e5c8d8dbc359a4459772142cf7346e427da20",
"url": "https://fuchsia.googlesource.com/integration/+/fd5e5c8d8dbc359a4459772142cf7346e427da20"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "92a289c8b4184581e1f55f9353195701e411011e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@92a289c8b4184581e1f55f9353195701e411011e",
"title": "92a289c8b4184581e1f55f9353195701e411011e",
"url": "https://fuchsia.googlesource.com/integration/+/92a289c8b4184581e1f55f9353195701e411011e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3b5a52ba8682c4dacf596ce5bce000dfd5aff6b2"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3b5a52ba8682c4dacf596ce5bce000dfd5aff6b2",
"title": "3b5a52ba8682c4dacf596ce5bce000dfd5aff6b2",
"url": "https://fuchsia.googlesource.com/integration/+/3b5a52ba8682c4dacf596ce5bce000dfd5aff6b2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8c5314e1afd03188cb1dd0f8c29320086be41ec9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8c5314e1afd03188cb1dd0f8c29320086be41ec9",
"title": "8c5314e1afd03188cb1dd0f8c29320086be41ec9",
"url": "https://fuchsia.googlesource.com/integration/+/8c5314e1afd03188cb1dd0f8c29320086be41ec9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "eb7e61a32bec7376eea37a7b1cd721a2243ac79f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@eb7e61a32bec7376eea37a7b1cd721a2243ac79f",
"title": "eb7e61a32bec7376eea37a7b1cd721a2243ac79f",
"url": "https://fuchsia.googlesource.com/integration/+/eb7e61a32bec7376eea37a7b1cd721a2243ac79f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6d6b5b8cd34e8e678520b49aee166b07e30ae651"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6d6b5b8cd34e8e678520b49aee166b07e30ae651",
"title": "6d6b5b8cd34e8e678520b49aee166b07e30ae651",
"url": "https://fuchsia.googlesource.com/integration/+/6d6b5b8cd34e8e678520b49aee166b07e30ae651"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e35d527798be1db4bed172a341a5a81aef75569d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e35d527798be1db4bed172a341a5a81aef75569d",
"title": "e35d527798be1db4bed172a341a5a81aef75569d",
"url": "https://fuchsia.googlesource.com/integration/+/e35d527798be1db4bed172a341a5a81aef75569d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "70398dc672635573c33d1c2b095a6df3a6d471fa"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@70398dc672635573c33d1c2b095a6df3a6d471fa",
"title": "70398dc672635573c33d1c2b095a6df3a6d471fa",
"url": "https://fuchsia.googlesource.com/integration/+/70398dc672635573c33d1c2b095a6df3a6d471fa"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4e076e6b9aa13637c76de7ab306a9153a83ab2e2"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4e076e6b9aa13637c76de7ab306a9153a83ab2e2",
"title": "4e076e6b9aa13637c76de7ab306a9153a83ab2e2",
"url": "https://fuchsia.googlesource.com/integration/+/4e076e6b9aa13637c76de7ab306a9153a83ab2e2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "cc55c9f6bec00172d828ac35f13accee8d5525ce"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@cc55c9f6bec00172d828ac35f13accee8d5525ce",
"title": "cc55c9f6bec00172d828ac35f13accee8d5525ce",
"url": "https://fuchsia.googlesource.com/integration/+/cc55c9f6bec00172d828ac35f13accee8d5525ce"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "97a8e7b1fa21a865e5b41d2a1acacbac19bdc3b7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@97a8e7b1fa21a865e5b41d2a1acacbac19bdc3b7",
"title": "97a8e7b1fa21a865e5b41d2a1acacbac19bdc3b7",
"url": "https://fuchsia.googlesource.com/integration/+/97a8e7b1fa21a865e5b41d2a1acacbac19bdc3b7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "103560cff3ac778b338b1255d079ccf285689843"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@103560cff3ac778b338b1255d079ccf285689843",
"title": "103560cff3ac778b338b1255d079ccf285689843",
"url": "https://fuchsia.googlesource.com/integration/+/103560cff3ac778b338b1255d079ccf285689843"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "71970121c1a4c1a266861dd3587985cdbe0e763e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@71970121c1a4c1a266861dd3587985cdbe0e763e",
"title": "71970121c1a4c1a266861dd3587985cdbe0e763e",
"url": "https://fuchsia.googlesource.com/integration/+/71970121c1a4c1a266861dd3587985cdbe0e763e"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "71970121c1a4c1a266861dd3587985cdbe0e763e",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8912545838899581008"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/minimal.riscv64-lto-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[20:49:23.548] Scheduled build:
{
"id": "8747115776932662001",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "minimal.riscv64-lto"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-23T20:49:23.115960189Z",
"updateTime": "2024-05-23T20:49:23.115960189Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "71970121c1a4c1a266861dd3587985cdbe0e763e",
"ref": "refs/heads/main"
}
}
}
[20:49:23.548] Task URL: https://cr-buildbucket.appspot.com/build/8747115776932662001
[20:49:23.548] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-lto-e5a0ec7f:8912545838899581008:2:0) after 2m20s
[20:49:24.472] Received PubSub notification, asking Buildbucket for the build status
[20:49:24.495] Build status: SCHEDULED
[20:51:16.525] Received PubSub notification, asking Buildbucket for the build status
[20:51:16.553] Build status: STARTED
[20:51:43.551] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-lto-e5a0ec7f:8912545838899581008:2:0)
[20:51:43.570] Build status: STARTED
[20:51:43.570] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-lto-e5a0ec7f:8912545838899581008:5:0) after 1m2s
[20:52:45.574] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-lto-e5a0ec7f:8912545838899581008:5:0)
[20:52:45.600] Build status: STARTED
[20:52:45.601] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-lto-e5a0ec7f:8912545838899581008:6:0) after 7m44s
[21:00:29.630] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-lto-e5a0ec7f:8912545838899581008:6:0)
[21:00:29.694] Build status: STARTED
[21:00:29.694] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-lto-e5a0ec7f:8912545838899581008:7:0) after 9m14s
[21:09:43.715] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-lto-e5a0ec7f:8912545838899581008:7:0)
[21:09:43.770] Build status: STARTED
[21:09:43.770] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-lto-e5a0ec7f:8912545838899581008:8:0) after 6m59s
[21:16:42.786] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-lto-e5a0ec7f:8912545838899581008:8:0)
[21:16:42.805] Build status: STARTED
[21:16:42.805] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-lto-e5a0ec7f:8912545838899581008:9:0) after 2m9s
[21:18:51.896] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-lto-e5a0ec7f:8912545838899581008:9:0)
[21:18:51.917] Build status: STARTED
[21:18:51.917] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-lto-e5a0ec7f:8912545838899581008:10:0) after 7m45s
[21:26:36.915] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-lto-e5a0ec7f:8912545838899581008:10:0)
[21:26:36.936] Build status: STARTED
[21:26:36.936] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-lto-e5a0ec7f:8912545838899581008:11:0) after 9m45s
[21:36:22.150] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-lto-e5a0ec7f:8912545838899581008:11:0)
[21:36:22.172] Build status: STARTED
[21:36:22.172] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-lto-e5a0ec7f:8912545838899581008:12:0) after 9m23s
[21:45:45.567] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-lto-e5a0ec7f:8912545838899581008:12:0)
[21:45:45.587] Build status: STARTED
[21:45:45.587] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-lto-e5a0ec7f:8912545838899581008:13:0) after 3m28s
[21:49:13.606] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-lto-e5a0ec7f:8912545838899581008:13:0)
[21:49:13.625] Build status: STARTED
[21:49:13.625] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-lto-e5a0ec7f:8912545838899581008:14:0) after 1m32s
[21:50:45.643] Handling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-lto-e5a0ec7f:8912545838899581008:14:0)
[21:50:45.673] Build status: STARTED
[21:50:45.673] Scheduling timer "check-buildbucket-build-status" (fuchsia/minimal.riscv64-lto-e5a0ec7f:8912545838899581008:15:0) after 7m7s
[21:57:31.147] Received PubSub notification, asking Buildbucket for the build status
[21:57:31.184] Build:
{
"id": "8747115776932662001",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "minimal.riscv64-lto"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-23T20:49:23.115960189Z",
"startTime": "2024-05-23T20:51:16.314821610Z",
"endTime": "2024-05-23T21:57:30.368484277Z",
"updateTime": "2024-05-23T21:57:30.368484277Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "71970121c1a4c1a266861dd3587985cdbe0e763e",
"ref": "refs/heads/main"
}
}
}
[21:57:31.184] Invocation finished in 1h8m9.328354719s with status SUCCEEDED