[21:41:00.510] New invocation is queued and will start shortly
[21:41:01.616] Starting the invocation (attempt 1)
[21:41:01.645] Popped buildset tag "buildset:commit/gitiles/pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/afad586fdbff83e929f0917c42958ca56d61b046"
[21:41:01.646] Popped gitiles commit info from properties and tags
[21:41:01.646] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:41:01.646] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:41:01.646] Buildbucket request:
{
"requestId": "8884910514986250832",
"builder": {
"project": "pigweed",
"bucket": "matter.ci",
"builder": "matter-envtest"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8884910514986250832",
"job": "pigweed/matter.ci-matter-envtest",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip",
"revision": "c3a4e1c3f4fafce8c761b11c8a8df9d75693413a"
},
"id": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/refs/heads/master@c3a4e1c3f4fafce8c761b11c8a8df9d75693413a",
"title": "c3a4e1c3f4fafce8c761b11c8a8df9d75693413a",
"url": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/c3a4e1c3f4fafce8c761b11c8a8df9d75693413a"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip",
"revision": "bfd7e6bd9d2b9126d174a3b3e38a01d2e5991eff"
},
"id": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/refs/heads/master@bfd7e6bd9d2b9126d174a3b3e38a01d2e5991eff",
"title": "bfd7e6bd9d2b9126d174a3b3e38a01d2e5991eff",
"url": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/bfd7e6bd9d2b9126d174a3b3e38a01d2e5991eff"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip",
"revision": "44de8d46a95a205354c98d8f2e9bb80251b536ac"
},
"id": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/refs/heads/master@44de8d46a95a205354c98d8f2e9bb80251b536ac",
"title": "44de8d46a95a205354c98d8f2e9bb80251b536ac",
"url": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/44de8d46a95a205354c98d8f2e9bb80251b536ac"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip",
"revision": "afad586fdbff83e929f0917c42958ca56d61b046"
},
"id": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/refs/heads/master@afad586fdbff83e929f0917c42958ca56d61b046",
"title": "afad586fdbff83e929f0917c42958ca56d61b046",
"url": "https://pigweed.googlesource.com/third_party/github/project-chip/connectedhomeip/+/afad586fdbff83e929f0917c42958ca56d61b046"
}
]
}
},
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "third_party/github/project-chip/connectedhomeip",
"id": "afad586fdbff83e929f0917c42958ca56d61b046",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8884910514986250832"
},
{
"key": "scheduler_job_id",
"value": "pigweed/matter.ci-matter-envtest"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[21:41:02.053] Scheduled build:
{
"id": "8719480453040775937",
"builder": {
"project": "pigweed",
"bucket": "matter.ci",
"builder": "matter-envtest"
},
"createdBy": "project:pigweed",
"createTime": "2025-03-24T21:41:01.736041697Z",
"updateTime": "2025-03-24T21:41:01.736041697Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "third_party/github/project-chip/connectedhomeip",
"id": "afad586fdbff83e929f0917c42958ca56d61b046",
"ref": "refs/heads/master"
}
}
}
[21:41:02.053] Task URL: https://cr-buildbucket.appspot.com/build/8719480453040775937
[21:41:02.053] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.ci-matter-envtest:8884910514986250832:2:0) after 2m27s
[21:41:12.549] Received PubSub notification, asking Buildbucket for the build status
[21:41:12.581] Build status: SCHEDULED
[21:41:24.824] Received PubSub notification, asking Buildbucket for the build status
[21:41:24.863] Build status: STARTED
[21:43:29.124] Handling timer "check-buildbucket-build-status" (pigweed/matter.ci-matter-envtest:8884910514986250832:2:0)
[21:43:29.159] Build status: STARTED
[21:43:29.159] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.ci-matter-envtest:8884910514986250832:5:0) after 3m5s
[21:46:34.279] Handling timer "check-buildbucket-build-status" (pigweed/matter.ci-matter-envtest:8884910514986250832:5:0)
[21:46:34.562] Build status: STARTED
[21:46:34.562] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.ci-matter-envtest:8884910514986250832:6:0) after 5m33s
[21:52:07.534] Handling timer "check-buildbucket-build-status" (pigweed/matter.ci-matter-envtest:8884910514986250832:6:0)
[21:52:07.556] Build status: STARTED
[21:52:07.556] Scheduling timer "check-buildbucket-build-status" (pigweed/matter.ci-matter-envtest:8884910514986250832:7:0) after 3m2s
[21:52:42.583] Received PubSub notification, asking Buildbucket for the build status
[21:52:42.614] Build:
{
"id": "8719480453040775937",
"builder": {
"project": "pigweed",
"bucket": "matter.ci",
"builder": "matter-envtest"
},
"createdBy": "project:pigweed",
"createTime": "2025-03-24T21:41:01.736041697Z",
"startTime": "2025-03-24T21:41:12.608491600Z",
"endTime": "2025-03-24T21:52:42.070338738Z",
"updateTime": "2025-03-24T21:52:42.070338738Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "third_party/github/project-chip/connectedhomeip",
"id": "afad586fdbff83e929f0917c42958ca56d61b046",
"ref": "refs/heads/master"
}
}
}
[21:52:42.614] Invocation finished in 11m42.117350431s with status SUCCEEDED