[21:08:12.276] New invocation is queued and will start shortly
[21:08:13.404] Starting the invocation (attempt 1)
[21:08:13.432] Popped buildset tag "buildset:commit/gitiles/pigweed.googlesource.com/pigweed/pigweed/+/058edafab8ef8b4f1ecade13b84c9c507b5deb89"
[21:08:13.432] Popped gitiles commit info from properties and tags
[21:08:13.432] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:08:13.432] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:08:13.432] Buildbucket request:
{
"requestId": "8935465686074310448",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-gn-san-msan"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8935465686074310448",
"job": "pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "21b27512aa72b95fc3e379742fa3cacb1e81bd42"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@21b27512aa72b95fc3e379742fa3cacb1e81bd42",
"title": "21b27512aa72b95fc3e379742fa3cacb1e81bd42",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/21b27512aa72b95fc3e379742fa3cacb1e81bd42"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "4d5ba83beb9c15b8600d9b575655a3a0ad2e9f37"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@4d5ba83beb9c15b8600d9b575655a3a0ad2e9f37",
"title": "4d5ba83beb9c15b8600d9b575655a3a0ad2e9f37",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/4d5ba83beb9c15b8600d9b575655a3a0ad2e9f37"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "058edafab8ef8b4f1ecade13b84c9c507b5deb89"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@058edafab8ef8b4f1ecade13b84c9c507b5deb89",
"title": "058edafab8ef8b4f1ecade13b84c9c507b5deb89",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/058edafab8ef8b4f1ecade13b84c9c507b5deb89"
}
]
}
},
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "058edafab8ef8b4f1ecade13b84c9c507b5deb89",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8935465686074310448"
},
{
"key": "scheduler_job_id",
"value": "pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[21:08:13.923] Scheduled build:
{
"id": "8770035624143522017",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-gn-san-msan"
},
"createdBy": "project:pigweed",
"createTime": "2023-09-13T21:08:13.494461771Z",
"updateTime": "2023-09-13T21:08:13.494461771Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "058edafab8ef8b4f1ecade13b84c9c507b5deb89",
"ref": "refs/heads/main"
}
}
}
[21:08:13.923] Task URL: https://cr-buildbucket.appspot.com/build/8770035624143522017
[21:08:13.924] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:2:0) after 2m10s
[21:08:14.092] Received PubSub notification, asking Buildbucket for the build status
[21:08:14.138] Build status: SCHEDULED
[21:10:24.038] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:2:0)
[21:10:24.060] Build status: SCHEDULED
[21:10:24.060] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:4:0) after 6m42s
[21:17:06.241] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:4:0)
[21:17:06.274] Build status: SCHEDULED
[21:17:06.274] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:5:0) after 1m34s
[21:18:40.596] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:5:0)
[21:18:40.638] Build status: SCHEDULED
[21:18:40.638] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:6:0) after 1m47s
[21:20:27.654] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:6:0)
[21:20:27.695] Build status: SCHEDULED
[21:20:27.695] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:7:0) after 5m15s
[21:25:42.942] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:7:0)
[21:25:42.967] Build status: SCHEDULED
[21:25:42.968] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:8:0) after 3m36s
[21:29:18.947] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:8:0)
[21:29:18.967] Build status: SCHEDULED
[21:29:18.967] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:9:0) after 2m11s
[21:31:30.472] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:9:0)
[21:31:30.493] Build status: SCHEDULED
[21:31:30.493] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:10:0) after 7m20s
[21:38:50.476] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:10:0)
[21:38:50.513] Build status: SCHEDULED
[21:38:50.513] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:11:0) after 2m42s
[21:41:32.540] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:11:0)
[21:41:32.564] Build status: SCHEDULED
[21:41:32.564] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:12:0) after 3m32s
[21:45:04.646] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:12:0)
[21:45:04.699] Build status: SCHEDULED
[21:45:04.699] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:13:0) after 5m15s
[21:50:19.778] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:13:0)
[21:50:19.832] Build status: SCHEDULED
[21:50:19.832] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:14:0) after 6m29s
[21:56:49.257] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:14:0)
[21:56:49.273] Build status: SCHEDULED
[21:56:49.273] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:15:0) after 6m52s
[22:03:41.605] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:15:0)
[22:03:41.632] Build status: SCHEDULED
[22:03:41.632] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:16:0) after 7m9s
[22:10:50.648] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:16:0)
[22:10:50.700] Build status: SCHEDULED
[22:10:50.700] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:17:0) after 6m6s
[22:16:56.815] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:17:0)
[22:16:56.907] Build status: SCHEDULED
[22:16:56.907] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:18:0) after 4m27s
[22:21:24.372] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:18:0)
[22:21:24.401] Build status: SCHEDULED
[22:21:24.401] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:19:0) after 7m8s
[22:28:32.416] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:19:0)
[22:28:32.439] Build status: SCHEDULED
[22:28:32.439] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:20:0) after 9m51s
[22:38:23.555] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:20:0)
[22:38:23.571] Build status: SCHEDULED
[22:38:23.571] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:21:0) after 9m24s
[22:47:47.608] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:21:0)
[22:47:47.644] Build status: SCHEDULED
[22:47:47.645] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:22:0) after 4m55s
[22:52:42.753] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:22:0)
[22:52:42.867] Build status: SCHEDULED
[22:52:42.867] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:23:0) after 1m41s
[22:54:24.233] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:23:0)
[22:54:24.256] Build status: SCHEDULED
[22:54:24.256] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:24:0) after 9m21s
[23:03:45.914] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:24:0)
[23:03:45.930] Build status: SCHEDULED
[23:03:45.931] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:25:0) after 5m17s
[23:09:03.068] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:25:0)
[23:09:03.140] Build status: SCHEDULED
[23:09:03.140] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:26:0) after 2m49s
[23:11:52.173] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:26:0)
[23:11:52.196] Build status: SCHEDULED
[23:11:52.196] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:27:0) after 2m45s
[23:14:37.287] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:27:0)
[23:14:37.306] Build status: SCHEDULED
[23:14:37.306] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:28:0) after 8m21s
[23:22:58.376] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:28:0)
[23:22:58.398] Build status: SCHEDULED
[23:22:58.400] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:29:0) after 1m20s
[23:24:18.417] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:29:0)
[23:24:18.439] Build status: SCHEDULED
[23:24:18.439] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san-msan:8935465686074310448:30:0) after 7m50s
[23:24:45.267] Received PubSub notification, asking Buildbucket for the build status
[23:24:45.286] Build status: STARTED
[23:29:36.930] Received PubSub notification, asking Buildbucket for the build status
[23:29:36.951] Build:
{
"id": "8770035624143522017",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-gn-san-msan"
},
"createdBy": "project:pigweed",
"createTime": "2023-09-13T21:08:13.494461771Z",
"startTime": "2023-09-13T23:24:44.499041Z",
"endTime": "2023-09-13T23:29:36.703732187Z",
"updateTime": "2023-09-13T23:29:36.703732187Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "058edafab8ef8b4f1ecade13b84c9c507b5deb89",
"ref": "refs/heads/main"
}
}
}
[23:29:36.951] Invocation finished in 2h21m24.68184251s with status FAILED