[21:36:03.355] New invocation is queued and will start shortly
[21:36:04.505] Starting the invocation (attempt 1)
[21:36:04.532] Popped buildset tag "buildset:commit/gitiles/pigweed.googlesource.com/pigweed/pigweed/+/8f18755dc9a225caacf2b190d1114ebfda4a2642"
[21:36:04.532] Popped gitiles commit info from properties and tags
[21:36:04.532] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:36:04.532] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:36:04.532] Buildbucket request:
{
"requestId": "8901037086591056368",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-mac-arm-gn-arduino-pico"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8901037086591056368",
"job": "pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "14204b516c1a0dd750fd8a8137dd15147a6085c1"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@14204b516c1a0dd750fd8a8137dd15147a6085c1",
"title": "14204b516c1a0dd750fd8a8137dd15147a6085c1",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/14204b516c1a0dd750fd8a8137dd15147a6085c1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "d31705b84d24f0ef17e6b8eef6cae13f96f942e4"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@d31705b84d24f0ef17e6b8eef6cae13f96f942e4",
"title": "d31705b84d24f0ef17e6b8eef6cae13f96f942e4",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/d31705b84d24f0ef17e6b8eef6cae13f96f942e4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "42cff573c2016f8d0f78ef2f0db8cd9941601ab4"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@42cff573c2016f8d0f78ef2f0db8cd9941601ab4",
"title": "42cff573c2016f8d0f78ef2f0db8cd9941601ab4",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/42cff573c2016f8d0f78ef2f0db8cd9941601ab4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "adbc84085a8f629b6ea7f0fea277b8f7f2fe9733"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@adbc84085a8f629b6ea7f0fea277b8f7f2fe9733",
"title": "adbc84085a8f629b6ea7f0fea277b8f7f2fe9733",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/adbc84085a8f629b6ea7f0fea277b8f7f2fe9733"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "90d013791456308b1cea8b53cfec351597ff5992"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@90d013791456308b1cea8b53cfec351597ff5992",
"title": "90d013791456308b1cea8b53cfec351597ff5992",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/90d013791456308b1cea8b53cfec351597ff5992"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "801fb32919777aefd7a734ce9c2c1e6aec782ab7"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@801fb32919777aefd7a734ce9c2c1e6aec782ab7",
"title": "801fb32919777aefd7a734ce9c2c1e6aec782ab7",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/801fb32919777aefd7a734ce9c2c1e6aec782ab7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "8f18755dc9a225caacf2b190d1114ebfda4a2642"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@8f18755dc9a225caacf2b190d1114ebfda4a2642",
"title": "8f18755dc9a225caacf2b190d1114ebfda4a2642",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/8f18755dc9a225caacf2b190d1114ebfda4a2642"
}
]
}
},
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "8f18755dc9a225caacf2b190d1114ebfda4a2642",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8901037086591056368"
},
{
"key": "scheduler_job_id",
"value": "pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[21:36:04.944] Scheduled build:
{
"id": "8735607024642351281",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-mac-arm-gn-arduino-pico"
},
"createdBy": "project:pigweed",
"createTime": "2024-09-27T21:36:04.588490712Z",
"updateTime": "2024-09-27T21:36:04.588490712Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "8f18755dc9a225caacf2b190d1114ebfda4a2642",
"ref": "refs/heads/main"
}
}
}
[21:36:04.944] Task URL: https://cr-buildbucket.appspot.com/build/8735607024642351281
[21:36:04.944] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:2:0) after 7m50s
[21:36:05.887] Received PubSub notification, asking Buildbucket for the build status
[21:36:05.909] Build status: SCHEDULED
[21:43:54.966] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:2:0)
[21:43:54.997] Build status: SCHEDULED
[21:43:54.997] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:4:0) after 4m34s
[21:48:29.014] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:4:0)
[21:48:29.041] Build status: SCHEDULED
[21:48:29.041] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:5:0) after 7m28s
[21:55:57.107] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:5:0)
[21:55:57.123] Build status: SCHEDULED
[21:55:57.123] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:6:0) after 2m6s
[21:58:03.138] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:6:0)
[21:58:03.181] Build status: SCHEDULED
[21:58:03.181] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:7:0) after 6m9s
[22:04:12.223] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:7:0)
[22:04:12.247] Build status: SCHEDULED
[22:04:12.247] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:8:0) after 7m18s
[22:11:30.352] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:8:0)
[22:11:30.371] Build status: SCHEDULED
[22:11:30.371] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:9:0) after 4m35s
[22:16:05.436] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:9:0)
[22:16:05.463] Build status: SCHEDULED
[22:16:05.463] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:10:0) after 2m41s
[22:18:46.527] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:10:0)
[22:18:46.545] Build status: SCHEDULED
[22:18:46.545] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:11:0) after 4m41s
[22:23:27.564] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:11:0)
[22:23:27.658] Build status: SCHEDULED
[22:23:27.658] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:12:0) after 6m7s
[22:29:34.726] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:12:0)
[22:29:34.746] Build status: SCHEDULED
[22:29:34.746] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:13:0) after 2m47s
[22:32:21.837] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:13:0)
[22:32:21.866] Build status: SCHEDULED
[22:32:21.866] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:14:0) after 9m34s
[22:41:55.862] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:14:0)
[22:41:55.882] Build status: SCHEDULED
[22:41:55.882] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:15:0) after 1m38s
[22:43:33.899] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:15:0)
[22:43:33.982] Build status: SCHEDULED
[22:43:33.983] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:16:0) after 6m44s
[22:50:18.030] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:16:0)
[22:50:18.047] Build status: SCHEDULED
[22:50:18.047] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:17:0) after 2m2s
[22:52:20.167] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:17:0)
[22:52:20.185] Build status: SCHEDULED
[22:52:20.185] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:18:0) after 6m38s
[22:58:58.305] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:18:0)
[22:58:58.325] Build status: SCHEDULED
[22:58:58.325] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:19:0) after 6m9s
[23:05:07.345] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:19:0)
[23:05:07.366] Build status: SCHEDULED
[23:05:07.366] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:20:0) after 6m0s
[23:11:07.428] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:20:0)
[23:11:07.449] Build status: SCHEDULED
[23:11:07.449] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:21:0) after 9m20s
[23:20:27.819] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:21:0)
[23:20:27.849] Build status: SCHEDULED
[23:20:27.849] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:22:0) after 2m42s
[23:23:09.867] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:22:0)
[23:23:09.886] Build status: SCHEDULED
[23:23:09.886] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:23:0) after 5m21s
[23:28:30.953] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:23:0)
[23:28:30.974] Build status: SCHEDULED
[23:28:30.974] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:24:0) after 3m37s
[23:32:07.950] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:24:0)
[23:32:08.024] Build status: SCHEDULED
[23:32:08.024] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:25:0) after 8m38s
[23:40:46.043] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:25:0)
[23:40:46.063] Build status: SCHEDULED
[23:40:46.063] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:26:0) after 3m26s
[23:44:12.075] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:26:0)
[23:44:12.130] Build status: SCHEDULED
[23:44:12.130] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:27:0) after 1m15s
[23:45:27.203] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:27:0)
[23:45:27.291] Build status: SCHEDULED
[23:45:27.291] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:28:0) after 8m10s
[23:53:37.357] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:28:0)
[23:53:37.442] Build status: SCHEDULED
[23:53:37.442] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:29:0) after 7m35s
[00:01:12.658] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:29:0)
[00:01:12.674] Build status: SCHEDULED
[00:01:12.675] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:30:0) after 8m12s
[00:09:24.772] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:30:0)
[00:09:24.790] Build status: SCHEDULED
[00:09:24.790] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:31:0) after 9m31s
[00:18:55.858] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:31:0)
[00:18:55.877] Build status: SCHEDULED
[00:18:55.877] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:32:0) after 1m4s
[00:19:59.892] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:32:0)
[00:19:59.917] Build status: SCHEDULED
[00:19:59.917] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:33:0) after 9m59s
[00:23:16.005] Received PubSub notification, asking Buildbucket for the build status
[00:23:16.042] Build status: STARTED
[00:29:58.977] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:33:0)
[00:29:58.993] Build status: STARTED
[00:29:58.994] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-arduino-pico:8901037086591056368:35:0) after 5m57s
[00:31:52.654] Received PubSub notification, asking Buildbucket for the build status
[00:31:52.674] Build:
{
"id": "8735607024642351281",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-mac-arm-gn-arduino-pico"
},
"createdBy": "project:pigweed",
"createTime": "2024-09-27T21:36:04.588490712Z",
"startTime": "2024-09-28T00:23:13.337867899Z",
"endTime": "2024-09-28T00:31:52.361468926Z",
"updateTime": "2024-09-28T00:31:52.361468926Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "8f18755dc9a225caacf2b190d1114ebfda4a2642",
"ref": "refs/heads/main"
}
}
}
[00:31:52.674] Invocation finished in 2h55m49.328197515s with status SUCCEEDED