[05:00:05.039] New invocation is queued and will start shortly
[05:00:06.436] Starting the invocation (attempt 1)
[05:00:06.462] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/external/github.com/google/perfetto/+/8e03a17889cb4da9cb89cc110cb45a1d192306b7"
[05:00:06.462] Popped gitiles commit info from properties and tags
[05:00:06.462] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:00:06.463] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:00:06.464] Buildbucket request:
{
"requestId": "8866129318692908032",
"builder": {
"project": "perfetto",
"bucket": "official",
"builder": "perfetto-official-builder-android"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8866129318692908032",
"job": "perfetto/perfetto-official-builder-android",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/upstream/main",
"repo": "https://chromium.googlesource.com/external/github.com/google/perfetto",
"revision": "a315ae31b3499192389039b50bf1fd2f67359d2a"
},
"id": "https://chromium.googlesource.com/external/github.com/google/perfetto/+/refs/heads/upstream/main@a315ae31b3499192389039b50bf1fd2f67359d2a",
"title": "a315ae31b3499192389039b50bf1fd2f67359d2a",
"url": "https://chromium.googlesource.com/external/github.com/google/perfetto/+/a315ae31b3499192389039b50bf1fd2f67359d2a"
},
{
"gitiles": {
"ref": "refs/heads/upstream/main",
"repo": "https://chromium.googlesource.com/external/github.com/google/perfetto",
"revision": "84ccfcb8a3e0ca57a9bc43ecbe23e27ccc9107b2"
},
"id": "https://chromium.googlesource.com/external/github.com/google/perfetto/+/refs/heads/upstream/main@84ccfcb8a3e0ca57a9bc43ecbe23e27ccc9107b2",
"title": "84ccfcb8a3e0ca57a9bc43ecbe23e27ccc9107b2",
"url": "https://chromium.googlesource.com/external/github.com/google/perfetto/+/84ccfcb8a3e0ca57a9bc43ecbe23e27ccc9107b2"
},
{
"gitiles": {
"ref": "refs/heads/upstream/main",
"repo": "https://chromium.googlesource.com/external/github.com/google/perfetto",
"revision": "4f1596e32040705859f63754574427f5dc0a1c68"
},
"id": "https://chromium.googlesource.com/external/github.com/google/perfetto/+/refs/heads/upstream/main@4f1596e32040705859f63754574427f5dc0a1c68",
"title": "4f1596e32040705859f63754574427f5dc0a1c68",
"url": "https://chromium.googlesource.com/external/github.com/google/perfetto/+/4f1596e32040705859f63754574427f5dc0a1c68"
},
{
"gitiles": {
"ref": "refs/heads/upstream/main",
"repo": "https://chromium.googlesource.com/external/github.com/google/perfetto",
"revision": "0052d543c022ad294ee603f0c3c117e0e8e547c4"
},
"id": "https://chromium.googlesource.com/external/github.com/google/perfetto/+/refs/heads/upstream/main@0052d543c022ad294ee603f0c3c117e0e8e547c4",
"title": "0052d543c022ad294ee603f0c3c117e0e8e547c4",
"url": "https://chromium.googlesource.com/external/github.com/google/perfetto/+/0052d543c022ad294ee603f0c3c117e0e8e547c4"
},
{
"gitiles": {
"ref": "refs/heads/upstream/main",
"repo": "https://chromium.googlesource.com/external/github.com/google/perfetto",
"revision": "8e03a17889cb4da9cb89cc110cb45a1d192306b7"
},
"id": "https://chromium.googlesource.com/external/github.com/google/perfetto/+/refs/heads/upstream/main@8e03a17889cb4da9cb89cc110cb45a1d192306b7",
"title": "8e03a17889cb4da9cb89cc110cb45a1d192306b7",
"url": "https://chromium.googlesource.com/external/github.com/google/perfetto/+/8e03a17889cb4da9cb89cc110cb45a1d192306b7"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "external/github.com/google/perfetto",
"id": "8e03a17889cb4da9cb89cc110cb45a1d192306b7",
"ref": "refs/heads/upstream/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8866129318692908032"
},
{
"key": "scheduler_job_id",
"value": "perfetto/perfetto-official-builder-android"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[05:00:06.866] Scheduled build:
{
"id": "8700699256483857905",
"builder": {
"project": "perfetto",
"bucket": "official",
"builder": "perfetto-official-builder-android"
},
"createdBy": "project:perfetto",
"createTime": "2025-10-18T05:00:06.524848921Z",
"updateTime": "2025-10-18T05:00:06.524848921Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "external/github.com/google/perfetto",
"id": "8e03a17889cb4da9cb89cc110cb45a1d192306b7",
"ref": "refs/heads/upstream/main"
}
}
}
[05:00:06.867] Task URL: https://cr-buildbucket.appspot.com/build/8700699256483857905
[05:00:06.867] Scheduling timer "check-buildbucket-build-status" (perfetto/perfetto-official-builder-android:8866129318692908032:2:0) after 4m5s
[05:00:09.208] Received PubSub notification, asking Buildbucket for the build status
[05:00:09.355] Build status: SCHEDULED
[05:04:11.885] Handling timer "check-buildbucket-build-status" (perfetto/perfetto-official-builder-android:8866129318692908032:2:0)
[05:04:11.902] Build status: SCHEDULED
[05:04:11.902] Scheduling timer "check-buildbucket-build-status" (perfetto/perfetto-official-builder-android:8866129318692908032:4:0) after 2m28s
[05:06:39.914] Handling timer "check-buildbucket-build-status" (perfetto/perfetto-official-builder-android:8866129318692908032:4:0)
[05:06:39.953] Build status: SCHEDULED
[05:06:39.953] Scheduling timer "check-buildbucket-build-status" (perfetto/perfetto-official-builder-android:8866129318692908032:5:0) after 4m3s
[05:10:43.128] Handling timer "check-buildbucket-build-status" (perfetto/perfetto-official-builder-android:8866129318692908032:5:0)
[05:10:43.151] Build status: SCHEDULED
[05:10:43.151] Scheduling timer "check-buildbucket-build-status" (perfetto/perfetto-official-builder-android:8866129318692908032:6:0) after 7m43s
[05:18:26.441] Handling timer "check-buildbucket-build-status" (perfetto/perfetto-official-builder-android:8866129318692908032:6:0)
[05:18:26.503] Build status: SCHEDULED
[05:18:26.503] Scheduling timer "check-buildbucket-build-status" (perfetto/perfetto-official-builder-android:8866129318692908032:7:0) after 2m12s
[05:20:05.049] Received PubSub notification, asking Buildbucket for the build status
[05:20:05.066] Build status: STARTED
[05:20:38.615] Handling timer "check-buildbucket-build-status" (perfetto/perfetto-official-builder-android:8866129318692908032:7:0)
[05:20:38.634] Build status: STARTED
[05:20:38.634] Scheduling timer "check-buildbucket-build-status" (perfetto/perfetto-official-builder-android:8866129318692908032:9:0) after 8m13s
[05:28:51.649] Handling timer "check-buildbucket-build-status" (perfetto/perfetto-official-builder-android:8866129318692908032:9:0)
[05:28:51.758] Build status: STARTED
[05:28:51.758] Scheduling timer "check-buildbucket-build-status" (perfetto/perfetto-official-builder-android:8866129318692908032:10:0) after 1m35s
[05:30:26.767] Handling timer "check-buildbucket-build-status" (perfetto/perfetto-official-builder-android:8866129318692908032:10:0)
[05:30:26.788] Build status: STARTED
[05:30:26.788] Scheduling timer "check-buildbucket-build-status" (perfetto/perfetto-official-builder-android:8866129318692908032:11:0) after 7m17s
[05:37:44.062] Handling timer "check-buildbucket-build-status" (perfetto/perfetto-official-builder-android:8866129318692908032:11:0)
[05:37:44.096] Build status: STARTED
[05:37:44.096] Scheduling timer "check-buildbucket-build-status" (perfetto/perfetto-official-builder-android:8866129318692908032:12:0) after 1m1s
[05:38:45.247] Handling timer "check-buildbucket-build-status" (perfetto/perfetto-official-builder-android:8866129318692908032:12:0)
[05:38:45.261] Build status: STARTED
[05:38:45.261] Scheduling timer "check-buildbucket-build-status" (perfetto/perfetto-official-builder-android:8866129318692908032:13:0) after 9m16s
[05:48:01.274] Handling timer "check-buildbucket-build-status" (perfetto/perfetto-official-builder-android:8866129318692908032:13:0)
[05:48:01.505] Build:
{
"id": "8700699256483857905",
"builder": {
"project": "perfetto",
"bucket": "official",
"builder": "perfetto-official-builder-android"
},
"createdBy": "project:perfetto",
"createTime": "2025-10-18T05:00:06.524848921Z",
"startTime": "2025-10-18T05:20:04.629724318Z",
"endTime": "2025-10-18T05:47:17.574838426Z",
"updateTime": "2025-10-18T05:47:17.574838426Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "external/github.com/google/perfetto",
"id": "8e03a17889cb4da9cb89cc110cb45a1d192306b7",
"ref": "refs/heads/upstream/main"
}
}
}
[05:48:01.505] Invocation finished in 47m56.471491579s with status SUCCEEDED