[23:24:28.621] New invocation is queued and will start shortly
[23:24:30.299] Starting the invocation (attempt 1)
[23:24:30.323] Popped buildset tag "buildset:commit/gitiles/pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/83159c252587e695cf791dada8eb2db55ffc471d"
[23:24:30.324] Popped gitiles commit info from properties and tags
[23:24:30.324] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:24:30.324] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:24:30.324] Buildbucket request:
{
"requestId": "8900667877462823456",
"builder": {
"project": "pigweed",
"bucket": "matter.dev.ci",
"builder": "matter-envtest"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8900667877462823456",
"job": "pigweed/matter.dev.ci-matter-envtest",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip",
"revision": "efd6e690a406619aedabba935a1734dd2582bb36"
},
"id": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/refs/heads/master@efd6e690a406619aedabba935a1734dd2582bb36",
"title": "efd6e690a406619aedabba935a1734dd2582bb36",
"url": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/efd6e690a406619aedabba935a1734dd2582bb36"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip",
"revision": "cd9cffb2860ad6b9b099bda9deac9ff08b70ab82"
},
"id": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/refs/heads/master@cd9cffb2860ad6b9b099bda9deac9ff08b70ab82",
"title": "cd9cffb2860ad6b9b099bda9deac9ff08b70ab82",
"url": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/cd9cffb2860ad6b9b099bda9deac9ff08b70ab82"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip",
"revision": "353f4dfc17427557b2fb0a96b1d34c6fad6c59ab"
},
"id": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/refs/heads/master@353f4dfc17427557b2fb0a96b1d34c6fad6c59ab",
"title": "353f4dfc17427557b2fb0a96b1d34c6fad6c59ab",
"url": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/353f4dfc17427557b2fb0a96b1d34c6fad6c59ab"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "a298967232681049f4cf8cec977a1802727339e9"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@a298967232681049f4cf8cec977a1802727339e9",
"title": "a298967232681049f4cf8cec977a1802727339e9",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/a298967232681049f4cf8cec977a1802727339e9"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "a298967232681049f4cf8cec977a1802727339e9"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/master@a298967232681049f4cf8cec977a1802727339e9",
"title": "a298967232681049f4cf8cec977a1802727339e9",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/a298967232681049f4cf8cec977a1802727339e9"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip",
"revision": "139b45a77b50d9d03b54e3a675a2513db2363fc9"
},
"id": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/refs/heads/master@139b45a77b50d9d03b54e3a675a2513db2363fc9",
"title": "139b45a77b50d9d03b54e3a675a2513db2363fc9",
"url": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/139b45a77b50d9d03b54e3a675a2513db2363fc9"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip",
"revision": "c5be5b1e932d6f5bd8e155afe06376be55c3be7c"
},
"id": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/refs/heads/master@c5be5b1e932d6f5bd8e155afe06376be55c3be7c",
"title": "c5be5b1e932d6f5bd8e155afe06376be55c3be7c",
"url": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/c5be5b1e932d6f5bd8e155afe06376be55c3be7c"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip",
"revision": "3e11cff89ba2d5248ebf37bfbf9785a04c5837a6"
},
"id": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/refs/heads/master@3e11cff89ba2d5248ebf37bfbf9785a04c5837a6",
"title": "3e11cff89ba2d5248ebf37bfbf9785a04c5837a6",
"url": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/3e11cff89ba2d5248ebf37bfbf9785a04c5837a6"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip",
"revision": "5cb0c71b4ab6f82619bdbc222881c72d82756cf3"
},
"id": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/refs/heads/master@5cb0c71b4ab6f82619bdbc222881c72d82756cf3",
"title": "5cb0c71b4ab6f82619bdbc222881c72d82756cf3",
"url": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/5cb0c71b4ab6f82619bdbc222881c72d82756cf3"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip",
"revision": "2880346a82b335cc67350a993835c0af9d776cd1"
},
"id": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/refs/heads/master@2880346a82b335cc67350a993835c0af9d776cd1",
"title": "2880346a82b335cc67350a993835c0af9d776cd1",
"url": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/2880346a82b335cc67350a993835c0af9d776cd1"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip",
"revision": "cb669b0cedfc8284c032516218a2a4dbe4167432"
},
"id": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/refs/heads/master@cb669b0cedfc8284c032516218a2a4dbe4167432",
"title": "cb669b0cedfc8284c032516218a2a4dbe4167432",
"url": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/cb669b0cedfc8284c032516218a2a4dbe4167432"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip",
"revision": "f6449902947e745e726f0bf0016a0f0b3643d1a7"
},
"id": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/refs/heads/master@f6449902947e745e726f0bf0016a0f0b3643d1a7",
"title": "f6449902947e745e726f0bf0016a0f0b3643d1a7",
"url": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/f6449902947e745e726f0bf0016a0f0b3643d1a7"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip",
"revision": "560c1e17617492a830f3b3a6f1ff74b16cd48741"
},
"id": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/refs/heads/master@560c1e17617492a830f3b3a6f1ff74b16cd48741",
"title": "560c1e17617492a830f3b3a6f1ff74b16cd48741",
"url": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/560c1e17617492a830f3b3a6f1ff74b16cd48741"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip",
"revision": "83159c252587e695cf791dada8eb2db55ffc471d"
},
"id": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/refs/heads/master@83159c252587e695cf791dada8eb2db55ffc471d",
"title": "83159c252587e695cf791dada8eb2db55ffc471d",
"url": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/83159c252587e695cf791dada8eb2db55ffc471d"
}
]
}
},
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "third_party/github/project-chip/connectedhomeip",
"id": "83159c252587e695cf791dada8eb2db55ffc471d",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8900667877462823456"
},
{
"key": "scheduler_job_id",
"value": "pigweed/matter.dev.ci-matter-envtest"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[23:24:30.836] Scheduled build:
{
"id": "8735237814925847265",
"builder": {
"project": "pigweed",
"bucket": "matter.dev.ci",
"builder": "matter-envtest"
},
"createdBy": "project:pigweed",
"createTime": "2024-10-01T23:24:30.412651409Z",
"updateTime": "2024-10-01T23:24:30.412651409Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "third_party/github/project-chip/connectedhomeip",
"id": "83159c252587e695cf791dada8eb2db55ffc471d",
"ref": "refs/heads/master"
}
}
}
[23:24:30.836] Task URL: https://cr-buildbucket.appspot.com/build/8735237814925847265
[23:24:30.836] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:2:0) after 4m44s
[23:24:31.776] Received PubSub notification, asking Buildbucket for the build status
[23:24:31.812] Build status: SCHEDULED
[23:29:14.857] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:2:0)
[23:29:14.885] Build status: SCHEDULED
[23:29:14.885] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:4:0) after 5m46s
[23:35:00.970] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:4:0)
[23:35:01.037] Build status: SCHEDULED
[23:35:01.037] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:5:0) after 1m26s
[23:36:27.123] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:5:0)
[23:36:30.501] Build status: SCHEDULED
[23:36:30.501] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:6:0) after 9m5s
[23:45:35.561] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:6:0)
[23:45:35.579] Build status: SCHEDULED
[23:45:35.579] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:7:0) after 3m34s
[23:49:09.729] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:7:0)
[23:49:09.750] Build status: SCHEDULED
[23:49:09.750] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:8:0) after 6m57s
[23:56:06.779] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:8:0)
[23:56:06.815] Build status: SCHEDULED
[23:56:06.815] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:9:0) after 1m21s
[23:57:27.834] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:9:0)
[23:57:27.868] Build status: SCHEDULED
[23:57:27.868] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:10:0) after 4m15s
[00:01:42.891] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:10:0)
[00:01:42.919] Build status: SCHEDULED
[00:01:42.919] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:11:0) after 8m48s
[00:10:30.953] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:11:0)
[00:10:30.970] Build status: SCHEDULED
[00:10:30.970] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:12:0) after 6m5s
[00:16:36.023] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:12:0)
[00:16:36.090] Build status: SCHEDULED
[00:16:36.090] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:13:0) after 8m5s
[00:24:41.112] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:13:0)
[00:24:41.133] Build status: SCHEDULED
[00:24:41.133] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:14:0) after 9m39s
[00:34:20.157] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:14:0)
[00:34:20.393] Build status: SCHEDULED
[00:34:20.393] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:15:0) after 3m4s
[00:37:24.543] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:15:0)
[00:37:24.565] Build status: SCHEDULED
[00:37:24.565] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:16:0) after 6m18s
[00:43:42.591] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:16:0)
[00:43:42.638] Build status: SCHEDULED
[00:43:42.639] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:17:0) after 7m29s
[00:51:11.660] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:17:0)
[00:51:11.691] Build status: SCHEDULED
[00:51:11.691] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:18:0) after 8m33s
[00:59:44.740] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:18:0)
[00:59:44.758] Build status: SCHEDULED
[00:59:44.758] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:19:0) after 3m20s
[01:03:04.778] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:19:0)
[01:03:04.813] Build status: SCHEDULED
[01:03:04.813] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:20:0) after 7m48s
[01:10:52.847] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:20:0)
[01:10:52.865] Build status: SCHEDULED
[01:10:52.865] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:21:0) after 1m8s
[01:12:00.931] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:21:0)
[01:12:00.959] Build status: SCHEDULED
[01:12:00.959] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:22:0) after 1m22s
[01:13:22.983] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:22:0)
[01:13:23.033] Build status: SCHEDULED
[01:13:23.033] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:23:0) after 6m12s
[01:19:35.052] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:23:0)
[01:19:35.081] Build status: SCHEDULED
[01:19:35.081] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:24:0) after 5m40s
[01:25:15.143] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:24:0)
[01:25:15.217] Build status: SCHEDULED
[01:25:15.217] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:25:0) after 7m47s
[01:33:02.293] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:25:0)
[01:33:02.314] Build status: SCHEDULED
[01:33:02.314] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:26:0) after 7m38s
[01:40:40.414] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:26:0)
[01:40:40.435] Build status: SCHEDULED
[01:40:40.435] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:27:0) after 9m34s
[01:50:14.455] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:27:0)
[01:50:14.477] Build status: SCHEDULED
[01:50:14.477] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:28:0) after 9m9s
[01:55:07.502] Received PubSub notification, asking Buildbucket for the build status
[01:55:07.565] Build status: STARTED
[01:59:23.557] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:28:0)
[01:59:23.605] Build status: STARTED
[01:59:23.605] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:30:0) after 2m3s
[02:01:26.715] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:30:0)
[02:01:26.771] Build status: STARTED
[02:01:26.771] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8900667877462823456:31:0) after 2m32s
[02:01:50.211] Received PubSub notification, asking Buildbucket for the build status
[02:01:50.232] Build:
{
"id": "8735237814925847265",
"builder": {
"project": "pigweed",
"bucket": "matter.dev.ci",
"builder": "matter-envtest"
},
"createdBy": "project:pigweed",
"createTime": "2024-10-01T23:24:30.412651409Z",
"startTime": "2024-10-02T01:55:07.324652273Z",
"endTime": "2024-10-02T02:01:49.850640082Z",
"updateTime": "2024-10-02T02:01:49.850640082Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "third_party/github/project-chip/connectedhomeip",
"id": "83159c252587e695cf791dada8eb2db55ffc471d",
"ref": "refs/heads/master"
}
}
}
[02:01:50.232] Invocation finished in 2h37m21.622803289s with status FAILED