[15:51:14.683] New invocation is queued and will start shortly
[15:51:14.683] Triggered by user:webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[15:51:15.787] Starting the invocation (attempt 1)
[15:51:15.820] Popped buildset tag "buildset:commit/gitiles/webrtc.googlesource.com/src/+/a0be70a87c68dd975835b1d1c1b1524449e78df6"
[15:51:15.820] Popped gitiles commit info from properties and tags
[15:51:15.820] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:51:15.820] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:51:15.821] Buildbucket request:
{
"requestId": "8952608454118631552",
"builder": {
"project": "webrtc",
"bucket": "perf",
"builder": "Perf Fuchsia"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8952608454118631552",
"job": "webrtc/Perf Fuchsia",
"triggers": [
{
"gitiles": {
"properties": {
"deps_revision_overrides": {
"src": "6a0997de01f8149f1e699584fef5b773eac51ecb"
},
"parent_builder_group": "client.webrtc",
"parent_buildername": "Fuchsia Builder",
"parent_got_revision": "6a0997de01f8149f1e699584fef5b773eac51ecb",
"parent_got_revision_cp": "refs/heads/main@{#39503}",
"revision": "6a0997de01f8149f1e699584fef5b773eac51ecb",
"swarm_hashes": {
"fuchsia_perf_tests": "1dfdfeffd687950ad0fd69a18a2af56c8357c041c05c47a5bef571bcec3d9bea/492"
},
"swarming_command_lines": {
"fuchsia_perf_tests": [
"bin/run_fuchsia_perf_tests"
]
}
},
"ref": "refs/heads/main",
"repo": "https://webrtc.googlesource.com/src",
"revision": "6a0997de01f8149f1e699584fef5b773eac51ecb",
"tags": [
"parent_buildername:Fuchsia Builder",
"parent_buildnumber:747",
"user_agent:recipe"
]
},
"id": "95a5e6ee-8623-4c95-9850-bf448395d5ef",
"title": "Fuchsia Builder/747"
},
{
"gitiles": {
"properties": {
"deps_revision_overrides": {
"src": "a0be70a87c68dd975835b1d1c1b1524449e78df6"
},
"parent_builder_group": "client.webrtc",
"parent_buildername": "Fuchsia Builder",
"parent_got_revision": "a0be70a87c68dd975835b1d1c1b1524449e78df6",
"parent_got_revision_cp": "refs/heads/main@{#39504}",
"revision": "a0be70a87c68dd975835b1d1c1b1524449e78df6",
"swarm_hashes": {
"fuchsia_perf_tests": "1dfdfeffd687950ad0fd69a18a2af56c8357c041c05c47a5bef571bcec3d9bea/492"
},
"swarming_command_lines": {
"fuchsia_perf_tests": [
"bin/run_fuchsia_perf_tests"
]
}
},
"ref": "refs/heads/main",
"repo": "https://webrtc.googlesource.com/src",
"revision": "a0be70a87c68dd975835b1d1c1b1524449e78df6",
"tags": [
"parent_buildername:Fuchsia Builder",
"parent_buildnumber:748",
"user_agent:recipe"
]
},
"id": "a3e85af1-58dc-4823-97c3-25935d5b529b",
"title": "Fuchsia Builder/748"
}
]
},
"deps_revision_overrides": {
"src": "a0be70a87c68dd975835b1d1c1b1524449e78df6"
},
"parent_builder_group": "client.webrtc",
"parent_buildername": "Fuchsia Builder",
"parent_got_revision": "a0be70a87c68dd975835b1d1c1b1524449e78df6",
"parent_got_revision_cp": "refs/heads/main@{#39504}",
"swarm_hashes": {
"fuchsia_perf_tests": "1dfdfeffd687950ad0fd69a18a2af56c8357c041c05c47a5bef571bcec3d9bea/492"
},
"swarming_command_lines": {
"fuchsia_perf_tests": [
"bin/run_fuchsia_perf_tests"
]
}
},
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "a0be70a87c68dd975835b1d1c1b1524449e78df6",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8952608454118631552"
},
{
"key": "scheduler_job_id",
"value": "webrtc/Perf Fuchsia"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "Fuchsia Builder"
},
{
"key": "parent_buildnumber",
"value": "748"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[15:51:16.283] Scheduled build:
{
"id": "8787178392167823825",
"builder": {
"project": "webrtc",
"bucket": "perf",
"builder": "Perf Fuchsia"
},
"number": 581,
"createdBy": "project:webrtc",
"createTime": "2023-03-08T15:51:15.917598264Z",
"updateTime": "2023-03-08T15:51:15.917598264Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "a0be70a87c68dd975835b1d1c1b1524449e78df6",
"ref": "refs/heads/main"
}
},
"canary": true
}
[15:51:16.283] Task URL: https://cr-buildbucket.appspot.com/build/8787178392167823825
[15:51:16.283] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:2:0) after 1m41s
[15:51:29.162] Received PubSub notification, asking Buildbucket for the build status
[15:51:29.193] Build status: STARTED
[15:52:57.410] Handling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:2:0)
[15:52:57.434] Build status: STARTED
[15:52:57.434] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:4:0) after 3m50s
[15:56:47.680] Handling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:4:0)
[15:56:47.715] Build status: STARTED
[15:56:47.715] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:5:0) after 9m35s
[16:06:22.805] Handling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:5:0)
[16:06:22.839] Build status: STARTED
[16:06:22.839] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:6:0) after 6m58s
[16:13:21.202] Handling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:6:0)
[16:13:21.229] Build status: STARTED
[16:13:21.229] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:7:0) after 4m26s
[16:17:47.277] Handling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:7:0)
[16:17:47.299] Build status: STARTED
[16:17:47.299] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:8:0) after 8m33s
[16:26:20.383] Handling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:8:0)
[16:26:20.404] Build status: STARTED
[16:26:20.404] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:9:0) after 5m49s
[16:32:09.433] Handling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:9:0)
[16:32:09.458] Build status: STARTED
[16:32:09.458] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:10:0) after 1m28s
[16:33:37.544] Handling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:10:0)
[16:33:37.570] Build status: STARTED
[16:33:37.570] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:11:0) after 2m51s
[16:36:28.772] Handling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:11:0)
[16:36:28.877] Build status: STARTED
[16:36:28.877] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:12:0) after 8m16s
[16:44:44.895] Handling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:12:0)
[16:44:44.929] Build status: STARTED
[16:44:44.929] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:13:0) after 7m16s
[16:52:00.951] Handling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:13:0)
[16:52:00.973] Build status: STARTED
[16:52:00.973] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:14:0) after 2m1s
[16:54:02.020] Handling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:14:0)
[16:54:02.050] Build status: STARTED
[16:54:02.051] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:15:0) after 2m39s
[16:56:41.105] Handling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:15:0)
[16:56:41.154] Build status: STARTED
[16:56:41.154] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:16:0) after 5m20s
[17:02:01.806] Handling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:16:0)
[17:02:01.833] Build status: STARTED
[17:02:01.833] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:17:0) after 1m42s
[17:03:43.882] Handling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:17:0)
[17:03:43.913] Build status: STARTED
[17:03:43.913] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:18:0) after 8m44s
[17:12:28.034] Handling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:18:0)
[17:12:28.056] Build status: STARTED
[17:12:28.056] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:19:0) after 8m33s
[17:21:01.070] Handling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:19:0)
[17:21:01.115] Build status: STARTED
[17:21:01.115] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:20:0) after 9m17s
[17:30:18.268] Handling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:20:0)
[17:30:18.302] Build status: STARTED
[17:30:18.302] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:21:0) after 1m8s
[17:31:26.318] Handling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:21:0)
[17:31:26.350] Build status: STARTED
[17:31:26.350] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:22:0) after 5m2s
[17:36:29.077] Handling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:22:0)
[17:36:29.098] Build status: STARTED
[17:36:29.098] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:23:0) after 4m51s
[17:41:20.114] Handling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:23:0)
[17:41:20.198] Build status: STARTED
[17:41:20.198] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:24:0) after 6m3s
[17:47:23.555] Handling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:24:0)
[17:47:23.581] Build status: STARTED
[17:47:23.581] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:25:0) after 8m48s
[17:56:11.656] Handling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:25:0)
[17:56:11.681] Build status: STARTED
[17:56:11.681] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:26:0) after 8m50s
[18:05:01.806] Handling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:26:0)
[18:05:01.879] Build status: STARTED
[18:05:01.879] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Fuchsia:8952608454118631552:27:0) after 6m44s
[18:06:25.847] Received PubSub notification, asking Buildbucket for the build status
[18:06:25.872] Build:
{
"id": "8787178392167823825",
"builder": {
"project": "webrtc",
"bucket": "perf",
"builder": "Perf Fuchsia"
},
"number": 581,
"createdBy": "project:webrtc",
"createTime": "2023-03-08T15:51:15.917598264Z",
"startTime": "2023-03-08T15:51:28.555590Z",
"endTime": "2023-03-08T18:06:25.609435858Z",
"updateTime": "2023-03-08T18:06:25.609435858Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "a0be70a87c68dd975835b1d1c1b1524449e78df6",
"ref": "refs/heads/main"
}
},
"canary": true
}
[18:06:25.872] Invocation finished in 2h15m11.198993746s with status SUCCEEDED