[21:12:02.249] New invocation is queued and will start shortly
[21:12:03.355] Starting the invocation (attempt 1)
[21:12:03.380] Popped buildset tag "buildset:commit/gitiles/pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/9acb8569367a944a3265167acf385f70c3dba8f1"
[21:12:03.380] Popped gitiles commit info from properties and tags
[21:12:03.380] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:12:03.380] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:12:03.380] Buildbucket request:
{
"requestId": "8888355022415066560",
"builder": {
"project": "pigweed",
"bucket": "matter.dev.ci",
"builder": "matter-envtest"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8888355022415066560",
"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": "0086ee2073ed45d591068a7e4a8321d9dab1e96d"
},
"id": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/refs/heads/master@0086ee2073ed45d591068a7e4a8321d9dab1e96d",
"title": "0086ee2073ed45d591068a7e4a8321d9dab1e96d",
"url": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/0086ee2073ed45d591068a7e4a8321d9dab1e96d"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip",
"revision": "ccbc1f222e5d8a0b29f3b3437a15edd46676281f"
},
"id": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/refs/heads/master@ccbc1f222e5d8a0b29f3b3437a15edd46676281f",
"title": "ccbc1f222e5d8a0b29f3b3437a15edd46676281f",
"url": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/ccbc1f222e5d8a0b29f3b3437a15edd46676281f"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip",
"revision": "d6ad86773b889d230db3b5729ab5282d0a70f17f"
},
"id": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/refs/heads/master@d6ad86773b889d230db3b5729ab5282d0a70f17f",
"title": "d6ad86773b889d230db3b5729ab5282d0a70f17f",
"url": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/d6ad86773b889d230db3b5729ab5282d0a70f17f"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip",
"revision": "33ca47e0901751ad86979be755c18ddaee808528"
},
"id": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/refs/heads/master@33ca47e0901751ad86979be755c18ddaee808528",
"title": "33ca47e0901751ad86979be755c18ddaee808528",
"url": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/33ca47e0901751ad86979be755c18ddaee808528"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip",
"revision": "207cdfa5364aba87e7fcaa866d22e6fd017f5bf8"
},
"id": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/refs/heads/master@207cdfa5364aba87e7fcaa866d22e6fd017f5bf8",
"title": "207cdfa5364aba87e7fcaa866d22e6fd017f5bf8",
"url": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/207cdfa5364aba87e7fcaa866d22e6fd017f5bf8"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip",
"revision": "9acb8569367a944a3265167acf385f70c3dba8f1"
},
"id": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/refs/heads/master@9acb8569367a944a3265167acf385f70c3dba8f1",
"title": "9acb8569367a944a3265167acf385f70c3dba8f1",
"url": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/9acb8569367a944a3265167acf385f70c3dba8f1"
}
]
}
},
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "third_party/github/project-chip/connectedhomeip",
"id": "9acb8569367a944a3265167acf385f70c3dba8f1",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8888355022415066560"
},
{
"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"
}
}
[21:12:04.240] Scheduled build:
{
"id": "8722924960423149905",
"builder": {
"project": "pigweed",
"bucket": "matter.dev.ci",
"builder": "matter-envtest"
},
"createdBy": "project:pigweed",
"createTime": "2025-02-14T21:12:03.513875904Z",
"updateTime": "2025-02-14T21:12:03.513875904Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "third_party/github/project-chip/connectedhomeip",
"id": "9acb8569367a944a3265167acf385f70c3dba8f1",
"ref": "refs/heads/master"
}
}
}
[21:12:04.240] Task URL: https://cr-buildbucket.appspot.com/build/8722924960423149905
[21:12:04.240] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:2:0) after 3m28s
[21:12:06.223] Received PubSub notification, asking Buildbucket for the build status
[21:12:06.248] Build status: SCHEDULED
[21:15:32.262] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:2:0)
[21:15:32.297] Build status: SCHEDULED
[21:15:32.297] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:4:0) after 8m41s
[21:24:13.270] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:4:0)
[21:24:13.423] Build status: SCHEDULED
[21:24:13.423] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:5:0) after 4m58s
[21:29:11.510] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:5:0)
[21:29:11.852] Build status: SCHEDULED
[21:29:11.852] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:6:0) after 1m11s
[21:30:22.870] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:6:0)
[21:30:22.908] Build status: SCHEDULED
[21:30:22.908] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:7:0) after 1m35s
[21:31:57.930] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:7:0)
[21:31:57.962] Build status: SCHEDULED
[21:31:57.962] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:8:0) after 2m29s
[21:34:26.982] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:8:0)
[21:34:27.024] Build status: SCHEDULED
[21:34:27.024] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:9:0) after 3m58s
[21:38:25.038] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:9:0)
[21:38:25.065] Build status: SCHEDULED
[21:38:25.065] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:10:0) after 8m35s
[21:47:00.137] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:10:0)
[21:47:00.182] Build status: SCHEDULED
[21:47:00.182] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:11:0) after 7m28s
[21:54:28.212] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:11:0)
[21:54:28.260] Build status: SCHEDULED
[21:54:28.260] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:12:0) after 7m57s
[22:02:25.283] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:12:0)
[22:02:25.326] Build status: SCHEDULED
[22:02:25.326] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:13:0) after 8m45s
[22:11:10.356] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:13:0)
[22:11:10.381] Build status: SCHEDULED
[22:11:10.381] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:14:0) after 4m20s
[22:15:30.430] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:14:0)
[22:15:30.448] Build status: SCHEDULED
[22:15:30.448] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:15:0) after 9m29s
[22:24:59.474] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:15:0)
[22:24:59.503] Build status: SCHEDULED
[22:24:59.503] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:16:0) after 7m41s
[22:32:40.627] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:16:0)
[22:32:40.708] Build status: SCHEDULED
[22:32:40.708] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:17:0) after 7m44s
[22:40:24.732] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:17:0)
[22:40:24.810] Build status: SCHEDULED
[22:40:24.810] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:18:0) after 2m40s
[22:43:04.834] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:18:0)
[22:43:04.852] Build status: SCHEDULED
[22:43:04.852] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:19:0) after 9m35s
[22:52:39.867] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:19:0)
[22:52:39.890] Build status: SCHEDULED
[22:52:39.890] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:20:0) after 1m13s
[22:53:52.871] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:20:0)
[22:53:52.905] Build status: SCHEDULED
[22:53:52.905] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:21:0) after 4m19s
[22:58:11.994] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:21:0)
[22:58:12.030] Build status: SCHEDULED
[22:58:12.030] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:22:0) after 6m25s
[23:04:37.010] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:22:0)
[23:04:37.034] Build status: SCHEDULED
[23:04:37.034] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:23:0) after 2m33s
[23:07:10.012] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:23:0)
[23:07:10.035] Build status: SCHEDULED
[23:07:10.035] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:24:0) after 4m14s
[23:11:24.057] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:24:0)
[23:11:24.135] Build status: SCHEDULED
[23:11:24.135] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:25:0) after 4m31s
[23:15:55.116] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:25:0)
[23:15:55.135] Build status: SCHEDULED
[23:15:55.135] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:26:0) after 6m42s
[23:22:37.163] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:26:0)
[23:22:37.183] Build status: SCHEDULED
[23:22:37.183] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:27:0) after 9m1s
[23:31:38.285] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:27:0)
[23:31:38.374] Build status: SCHEDULED
[23:31:38.374] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:28:0) after 1m32s
[23:33:10.392] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:28:0)
[23:33:10.421] Build status: SCHEDULED
[23:33:10.421] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:29:0) after 6m18s
[23:39:28.535] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:29:0)
[23:39:28.555] Build status: SCHEDULED
[23:39:28.555] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:30:0) after 8m8s
[23:47:36.597] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:30:0)
[23:47:36.635] Build status: SCHEDULED
[23:47:36.635] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:31:0) after 9m59s
[23:54:22.085] Received PubSub notification, asking Buildbucket for the build status
[23:54:22.104] Build status: STARTED
[23:57:35.658] Handling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:31:0)
[23:57:35.717] Build status: STARTED
[23:57:35.717] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.dev.ci-matter-envtest:8888355022415066560:33:0) after 7m43s
[00:03:35.031] Received PubSub notification, asking Buildbucket for the build status
[00:03:35.109] Build:
{
"id": "8722924960423149905",
"builder": {
"project": "pigweed",
"bucket": "matter.dev.ci",
"builder": "matter-envtest"
},
"createdBy": "project:pigweed",
"createTime": "2025-02-14T21:12:03.513875904Z",
"startTime": "2025-02-14T23:54:20.935210875Z",
"endTime": "2025-02-15T00:03:34.662230489Z",
"updateTime": "2025-02-15T00:03:34.662230489Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "third_party/github/project-chip/connectedhomeip",
"id": "9acb8569367a944a3265167acf385f70c3dba8f1",
"ref": "refs/heads/master"
}
}
}
[00:03:35.109] Invocation finished in 2h51m32.879092088s with status SUCCEEDED