[00:05:32.838] New invocation is queued and will start shortly
[00:05:33.975] Starting the invocation (attempt 1)
[00:05:34.000] Popped buildset tag "buildset:commit/gitiles/pigweed.googlesource.com/pigweed/pigweed/+/144c02830735a1db6e3d0329ebca83359bf00363"
[00:05:34.000] Popped gitiles commit info from properties and tags
[00:05:34.000] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:05:34.001] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:05:34.001] Buildbucket request:
{
"requestId": "8896588430060754592",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-lintformat-full"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8896588430060754592",
"job": "pigweed/pigweed.dev.ci-pigweed-lintformat-full",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "786f3bcbb77cf5c3164a509f9b0c7c0b8a354101"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@786f3bcbb77cf5c3164a509f9b0c7c0b8a354101",
"title": "786f3bcbb77cf5c3164a509f9b0c7c0b8a354101",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/786f3bcbb77cf5c3164a509f9b0c7c0b8a354101"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "c064969881352ab973b449cfaa4b70dbaaf2aaaf"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@c064969881352ab973b449cfaa4b70dbaaf2aaaf",
"title": "c064969881352ab973b449cfaa4b70dbaaf2aaaf",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/c064969881352ab973b449cfaa4b70dbaaf2aaaf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "92e854a4d179f0b340a0f8b5a662012ea4b8635c"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@92e854a4d179f0b340a0f8b5a662012ea4b8635c",
"title": "92e854a4d179f0b340a0f8b5a662012ea4b8635c",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/92e854a4d179f0b340a0f8b5a662012ea4b8635c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "4dda09640e9e4196d3f9dd1b4868e42325d156d6"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@4dda09640e9e4196d3f9dd1b4868e42325d156d6",
"title": "4dda09640e9e4196d3f9dd1b4868e42325d156d6",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/4dda09640e9e4196d3f9dd1b4868e42325d156d6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "81b8314db83ecfdbb8feba98b021bb718df08482"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@81b8314db83ecfdbb8feba98b021bb718df08482",
"title": "81b8314db83ecfdbb8feba98b021bb718df08482",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/81b8314db83ecfdbb8feba98b021bb718df08482"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "144c02830735a1db6e3d0329ebca83359bf00363"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@144c02830735a1db6e3d0329ebca83359bf00363",
"title": "144c02830735a1db6e3d0329ebca83359bf00363",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/144c02830735a1db6e3d0329ebca83359bf00363"
}
]
}
},
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "144c02830735a1db6e3d0329ebca83359bf00363",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8896588430060754592"
},
{
"key": "scheduler_job_id",
"value": "pigweed/pigweed.dev.ci-pigweed-lintformat-full"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[00:05:34.434] Scheduled build:
{
"id": "8731158368104689745",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-lintformat-full"
},
"createdBy": "project:pigweed",
"createTime": "2024-11-16T00:05:34.071843900Z",
"updateTime": "2024-11-16T00:05:34.071843900Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "144c02830735a1db6e3d0329ebca83359bf00363",
"ref": "refs/heads/main"
}
}
}
[00:05:34.434] Task URL: https://cr-buildbucket.appspot.com/build/8731158368104689745
[00:05:34.434] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:2:0) after 4m45s
[00:05:35.439] Received PubSub notification, asking Buildbucket for the build status
[00:05:35.521] Build status: SCHEDULED
[00:10:19.515] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:2:0)
[00:10:19.696] Build status: SCHEDULED
[00:10:19.696] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:4:0) after 8m8s
[00:18:27.710] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:4:0)
[00:18:27.731] Build status: SCHEDULED
[00:18:27.731] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:5:0) after 3m41s
[00:22:08.819] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:5:0)
[00:22:08.838] Build status: SCHEDULED
[00:22:08.838] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:6:0) after 2m34s
[00:24:42.843] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:6:0)
[00:24:42.870] Build status: SCHEDULED
[00:24:42.870] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:7:0) after 8m23s
[00:33:05.837] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:7:0)
[00:33:05.873] Build status: SCHEDULED
[00:33:05.873] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:8:0) after 5m6s
[00:38:11.895] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:8:0)
[00:38:11.912] Build status: SCHEDULED
[00:38:11.912] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:9:0) after 3m43s
[00:41:54.911] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:9:0)
[00:41:54.935] Build status: SCHEDULED
[00:41:54.935] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:10:0) after 5m24s
[00:47:18.959] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:10:0)
[00:47:19.037] Build status: SCHEDULED
[00:47:19.037] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:11:0) after 7m14s
[00:54:33.155] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:11:0)
[00:54:33.445] Build status: SCHEDULED
[00:54:33.445] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:12:0) after 6m2s
[01:00:35.501] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:12:0)
[01:00:35.559] Build status: SCHEDULED
[01:00:35.559] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:13:0) after 9m50s
[01:10:25.540] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:13:0)
[01:10:25.565] Build status: SCHEDULED
[01:10:25.565] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:14:0) after 2m57s
[01:13:22.600] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:14:0)
[01:13:22.616] Build status: SCHEDULED
[01:13:22.616] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:15:0) after 5m18s
[01:18:40.630] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:15:0)
[01:18:40.654] Build status: SCHEDULED
[01:18:40.654] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:16:0) after 6m52s
[01:25:32.672] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:16:0)
[01:25:32.688] Build status: SCHEDULED
[01:25:32.688] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:17:0) after 9m15s
[01:34:47.704] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:17:0)
[01:34:47.724] Build status: SCHEDULED
[01:34:47.724] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:18:0) after 5m31s
[01:40:18.749] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:18:0)
[01:40:18.767] Build status: SCHEDULED
[01:40:18.767] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:19:0) after 6m53s
[01:47:11.891] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:19:0)
[01:47:11.914] Build status: SCHEDULED
[01:47:11.915] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:20:0) after 1m27s
[01:48:38.941] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:20:0)
[01:48:38.960] Build status: SCHEDULED
[01:48:38.960] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:21:0) after 1m15s
[01:49:53.991] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:21:0)
[01:49:54.011] Build status: SCHEDULED
[01:49:54.011] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:22:0) after 6m28s
[01:56:22.037] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:22:0)
[01:56:22.097] Build status: SCHEDULED
[01:56:22.097] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:23:0) after 1m9s
[01:57:31.118] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:23:0)
[01:57:31.170] Build status: SCHEDULED
[01:57:31.170] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:24:0) after 2m32s
[02:00:03.360] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:24:0)
[02:00:03.391] Build status: SCHEDULED
[02:00:03.391] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:25:0) after 3m8s
[02:03:11.421] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:25:0)
[02:03:11.438] Build status: SCHEDULED
[02:03:11.438] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:26:0) after 6m2s
[02:09:13.463] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:26:0)
[02:09:13.484] Build status: SCHEDULED
[02:09:13.484] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:27:0) after 8m18s
[02:17:31.535] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:27:0)
[02:17:31.556] Build status: SCHEDULED
[02:17:31.556] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:28:0) after 2m22s
[02:19:53.574] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:28:0)
[02:19:53.595] Build status: SCHEDULED
[02:19:53.595] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:29:0) after 5m46s
[02:25:39.633] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:29:0)
[02:25:39.654] Build status: SCHEDULED
[02:25:39.654] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:30:0) after 7m26s
[02:33:05.662] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:30:0)
[02:33:05.678] Build status: SCHEDULED
[02:33:05.678] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:31:0) after 6m25s
[02:39:30.752] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:31:0)
[02:39:30.777] Build status: SCHEDULED
[02:39:30.777] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:32:0) after 2m23s
[02:41:53.788] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:32:0)
[02:41:53.809] Build status: SCHEDULED
[02:41:53.809] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:33:0) after 5m22s
[02:47:15.826] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:33:0)
[02:47:15.850] Build status: SCHEDULED
[02:47:15.850] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:34:0) after 3m25s
[02:50:40.820] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:34:0)
[02:50:40.869] Build status: SCHEDULED
[02:50:40.869] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:35:0) after 7m53s
[02:56:38.842] Received PubSub notification, asking Buildbucket for the build status
[02:56:38.861] Build status: STARTED
[02:58:33.887] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:35:0)
[02:58:33.949] Build status: STARTED
[02:58:33.949] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:37:0) after 2m46s
[03:01:19.959] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:37:0)
[03:01:20.114] Build status: STARTED
[03:01:20.114] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:38:0) after 8m0s
[03:09:20.132] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:38:0)
[03:09:20.160] Build status: STARTED
[03:09:20.160] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8896588430060754592:39:0) after 8m11s
[03:12:25.090] Received PubSub notification, asking Buildbucket for the build status
[03:12:25.123] Build:
{
"id": "8731158368104689745",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-lintformat-full"
},
"createdBy": "project:pigweed",
"createTime": "2024-11-16T00:05:34.071843900Z",
"startTime": "2024-11-16T02:56:38.573010274Z",
"endTime": "2024-11-16T03:12:24.529761723Z",
"updateTime": "2024-11-16T03:12:24.529761723Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "144c02830735a1db6e3d0329ebca83359bf00363",
"ref": "refs/heads/main"
}
}
}
[03:12:25.123] Invocation finished in 3h6m52.301596319s with status SUCCEEDED