[00:51:44.448] New invocation is queued and will start shortly
[00:51:45.602] Starting the invocation (attempt 1)
[00:51:45.628] Popped buildset tag "buildset:commit/gitiles/pigweed.googlesource.com/pigweed/pigweed/+/506466d72aa5cbf02128d6e967bc2292f1a09b44"
[00:51:45.628] Popped gitiles commit info from properties and tags
[00:51:45.628] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:51:45.628] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:51:45.628] Buildbucket request:
{
"requestId": "8912711783828814896",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-gn-fuzz"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8912711783828814896",
"job": "pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "cae40e3337b2234b2618cd506ecbb089c25a4e40"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@cae40e3337b2234b2618cd506ecbb089c25a4e40",
"title": "cae40e3337b2234b2618cd506ecbb089c25a4e40",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/cae40e3337b2234b2618cd506ecbb089c25a4e40"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "cd15ca3178ec45ef6cc27453326004d102c8dc4c"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@cd15ca3178ec45ef6cc27453326004d102c8dc4c",
"title": "cd15ca3178ec45ef6cc27453326004d102c8dc4c",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/cd15ca3178ec45ef6cc27453326004d102c8dc4c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "506466d72aa5cbf02128d6e967bc2292f1a09b44"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@506466d72aa5cbf02128d6e967bc2292f1a09b44",
"title": "506466d72aa5cbf02128d6e967bc2292f1a09b44",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/506466d72aa5cbf02128d6e967bc2292f1a09b44"
}
]
}
},
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "506466d72aa5cbf02128d6e967bc2292f1a09b44",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8912711783828814896"
},
{
"key": "scheduler_job_id",
"value": "pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[00:51:46.063] Scheduled build:
{
"id": "8747281721869306577",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-gn-fuzz"
},
"createdBy": "project:pigweed",
"createTime": "2024-05-22T00:51:45.691680447Z",
"updateTime": "2024-05-22T00:51:45.691680447Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "506466d72aa5cbf02128d6e967bc2292f1a09b44",
"ref": "refs/heads/main"
}
}
}
[00:51:46.063] Task URL: https://cr-buildbucket.appspot.com/build/8747281721869306577
[00:51:46.063] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:2:0) after 4m23s
[00:51:46.187] Received PubSub notification, asking Buildbucket for the build status
[00:51:46.222] Build status: SCHEDULED
[00:56:09.129] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:2:0)
[00:56:09.159] Build status: SCHEDULED
[00:56:09.159] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:4:0) after 7m45s
[01:03:54.192] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:4:0)
[01:03:54.276] Build status: SCHEDULED
[01:03:54.276] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:5:0) after 6m52s
[01:10:46.468] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:5:0)
[01:10:46.494] Build status: SCHEDULED
[01:10:46.495] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:6:0) after 1m59s
[01:12:45.510] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:6:0)
[01:12:45.556] Build status: SCHEDULED
[01:12:45.556] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:7:0) after 3m59s
[01:16:44.592] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:7:0)
[01:16:44.615] Build status: SCHEDULED
[01:16:44.615] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:8:0) after 3m30s
[01:20:14.625] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:8:0)
[01:20:14.656] Build status: SCHEDULED
[01:20:14.663] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:9:0) after 7m20s
[01:27:34.752] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:9:0)
[01:27:34.772] Build status: SCHEDULED
[01:27:34.772] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:10:0) after 8m35s
[01:36:09.800] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:10:0)
[01:36:09.819] Build status: SCHEDULED
[01:36:09.819] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:11:0) after 9m31s
[01:45:40.866] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:11:0)
[01:45:40.886] Build status: SCHEDULED
[01:45:40.886] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:12:0) after 4m4s
[01:49:44.933] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:12:0)
[01:49:44.953] Build status: SCHEDULED
[01:49:44.953] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:13:0) after 1m1s
[01:50:45.966] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:13:0)
[01:50:45.993] Build status: SCHEDULED
[01:50:45.993] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:14:0) after 8m33s
[01:59:19.013] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:14:0)
[01:59:19.062] Build status: SCHEDULED
[01:59:19.062] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:15:0) after 2m59s
[02:02:18.170] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:15:0)
[02:02:18.258] Build status: SCHEDULED
[02:02:18.258] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:16:0) after 3m21s
[02:05:39.343] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:16:0)
[02:05:39.367] Build status: SCHEDULED
[02:05:39.367] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:17:0) after 8m58s
[02:14:37.400] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:17:0)
[02:14:37.446] Build status: SCHEDULED
[02:14:37.446] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:18:0) after 5m41s
[02:20:18.464] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:18:0)
[02:20:18.482] Build status: SCHEDULED
[02:20:18.482] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:19:0) after 3m56s
[02:24:14.498] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:19:0)
[02:24:14.534] Build status: SCHEDULED
[02:24:14.534] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:20:0) after 4m29s
[02:28:43.602] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:20:0)
[02:28:43.627] Build status: SCHEDULED
[02:28:43.627] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:21:0) after 3m47s
[02:32:30.628] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:21:0)
[02:32:30.678] Build status: SCHEDULED
[02:32:30.678] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:22:0) after 5m51s
[02:38:21.799] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:22:0)
[02:38:21.818] Build status: SCHEDULED
[02:38:21.818] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:23:0) after 1m35s
[02:39:56.896] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:23:0)
[02:39:56.922] Build status: SCHEDULED
[02:39:56.922] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:24:0) after 3m24s
[02:43:20.943] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:24:0)
[02:43:20.968] Build status: SCHEDULED
[02:43:20.968] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:25:0) after 5m26s
[02:48:46.985] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:25:0)
[02:48:47.003] Build status: SCHEDULED
[02:48:47.003] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:26:0) after 4m30s
[02:53:17.026] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:26:0)
[02:53:17.045] Build status: SCHEDULED
[02:53:17.045] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:27:0) after 9m10s
[03:02:27.129] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:27:0)
[03:02:27.152] Build status: SCHEDULED
[03:02:27.152] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:28:0) after 2m16s
[03:04:43.172] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:28:0)
[03:04:43.196] Build status: SCHEDULED
[03:04:43.196] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:29:0) after 1m5s
[03:05:48.330] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:29:0)
[03:05:48.355] Build status: SCHEDULED
[03:05:48.355] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:30:0) after 9m26s
[03:15:14.384] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:30:0)
[03:15:14.477] Build status: SCHEDULED
[03:15:14.477] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:31:0) after 6m0s
[03:19:18.227] Received PubSub notification, asking Buildbucket for the build status
[03:19:18.277] Build status: STARTED
[03:21:14.513] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:31:0)
[03:21:14.594] Build status: STARTED
[03:21:14.594] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:33:0) after 2m56s
[03:24:10.934] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:33:0)
[03:24:10.959] Build status: STARTED
[03:24:10.959] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:34:0) after 3m45s
[03:27:56.086] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:34:0)
[03:27:56.104] Build status: STARTED
[03:27:56.104] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:35:0) after 1m58s
[03:29:54.279] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:35:0)
[03:29:54.297] Build status: STARTED
[03:29:54.297] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:36:0) after 1m37s
[03:31:31.515] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:36:0)
[03:31:31.551] Build status: STARTED
[03:31:31.551] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-fuzz:8912711783828814896:37:0) after 7m58s
[03:32:55.799] Received PubSub notification, asking Buildbucket for the build status
[03:32:55.817] Build:
{
"id": "8747281721869306577",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-gn-fuzz"
},
"createdBy": "project:pigweed",
"createTime": "2024-05-22T00:51:45.691680447Z",
"startTime": "2024-05-22T03:19:17.923406092Z",
"endTime": "2024-05-22T03:32:55.522532701Z",
"updateTime": "2024-05-22T03:32:55.522532701Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "506466d72aa5cbf02128d6e967bc2292f1a09b44",
"ref": "refs/heads/main"
}
}
}
[03:32:55.817] Invocation finished in 2h41m11.377889092s with status SUCCEEDED