[18:54:23.227] New invocation is queued and will start shortly
[18:54:24.316] Starting the invocation (attempt 1)
[18:54:24.348] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2a6b132a2f85ee7aaafb1b6eb064d68823a65d43"
[18:54:24.348] Popped gitiles commit info from properties and tags
[18:54:24.348] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:54:24.348] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:54:24.349] Buildbucket request:
{
"requestId": "8900231885218505424",
"builder": {
"project": "chromium",
"bucket": "build",
"builder": "linux-build-perf-siso"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "2a6b132a2f85ee7aaafb1b6eb064d68823a65d43",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8900231885218505424"
},
{
"key": "scheduler_job_id",
"value": "chromium/linux-build-perf-siso"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[18:54:25.187] Scheduled build:
{
"id": "8734801823288368689",
"builder": {
"project": "chromium",
"bucket": "build",
"builder": "linux-build-perf-siso"
},
"number": 2721,
"createdBy": "project:chromium",
"createTime": "2024-10-06T18:54:24.439144409Z",
"updateTime": "2024-10-06T18:54:24.439144409Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "2a6b132a2f85ee7aaafb1b6eb064d68823a65d43",
"ref": "refs/heads/main"
}
}
}
[18:54:25.187] Task URL: https://cr-buildbucket.appspot.com/build/8734801823288368689
[18:54:25.187] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:2:0) after 2m33s
[18:54:25.264] Received PubSub notification, asking Buildbucket for the build status
[18:54:25.280] Build status: SCHEDULED
[18:54:31.034] Received PubSub notification, asking Buildbucket for the build status
[18:54:31.060] Build status: STARTED
[18:56:58.301] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:2:0)
[18:56:58.334] Build status: STARTED
[18:56:58.334] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:5:0) after 9m28s
[19:06:26.359] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:5:0)
[19:06:26.401] Build status: STARTED
[19:06:26.401] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:6:0) after 1m31s
[19:07:57.418] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:6:0)
[19:07:57.443] Build status: STARTED
[19:07:57.443] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:7:0) after 4m26s
[19:12:23.521] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:7:0)
[19:12:23.540] Build status: STARTED
[19:12:23.540] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:8:0) after 3m58s
[19:16:21.687] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:8:0)
[19:16:21.735] Build status: STARTED
[19:16:21.735] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:9:0) after 2m13s
[19:18:34.751] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:9:0)
[19:18:34.845] Build status: STARTED
[19:18:34.845] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:10:0) after 5m29s
[19:24:03.862] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:10:0)
[19:24:03.940] Build status: STARTED
[19:24:03.940] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:11:0) after 4m47s
[19:28:51.058] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:11:0)
[19:28:51.075] Build status: STARTED
[19:28:51.075] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:12:0) after 1m57s
[19:30:48.090] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:12:0)
[19:30:48.108] Build status: STARTED
[19:30:48.108] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:13:0) after 8m24s
[19:39:13.680] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:13:0)
[19:39:13.701] Build status: STARTED
[19:39:13.701] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:14:0) after 9m29s
[19:48:42.728] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:14:0)
[19:48:42.744] Build status: STARTED
[19:48:42.744] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:15:0) after 2m45s
[19:51:27.769] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:15:0)
[19:51:27.935] Build status: STARTED
[19:51:27.935] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:16:0) after 5m24s
[19:56:52.012] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:16:0)
[19:56:52.033] Build status: STARTED
[19:56:52.033] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:17:0) after 1m43s
[19:58:35.049] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:17:0)
[19:58:35.070] Build status: STARTED
[19:58:35.070] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:18:0) after 3m52s
[20:02:27.088] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:18:0)
[20:02:27.111] Build status: STARTED
[20:02:27.111] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:19:0) after 2m24s
[20:04:51.128] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:19:0)
[20:04:51.160] Build status: STARTED
[20:04:51.160] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:20:0) after 1m22s
[20:06:13.421] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:20:0)
[20:06:13.489] Build status: STARTED
[20:06:13.489] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:21:0) after 6m33s
[20:12:46.502] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:21:0)
[20:12:46.517] Build status: STARTED
[20:12:46.517] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:22:0) after 3m14s
[20:16:00.548] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:22:0)
[20:16:00.565] Build status: STARTED
[20:16:00.565] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:23:0) after 2m9s
[20:18:09.542] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:23:0)
[20:18:09.563] Build status: STARTED
[20:18:09.563] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:24:0) after 8m21s
[20:26:30.575] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:24:0)
[20:26:30.593] Build status: STARTED
[20:26:30.593] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:25:0) after 8m49s
[20:35:19.610] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:25:0)
[20:35:19.629] Build status: STARTED
[20:35:19.629] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:26:0) after 2m14s
[20:37:33.656] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:26:0)
[20:37:33.679] Build status: STARTED
[20:37:33.679] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:27:0) after 1m51s
[20:39:24.698] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:27:0)
[20:39:24.743] Build status: STARTED
[20:39:24.743] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:28:0) after 2m41s
[20:42:05.767] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:28:0)
[20:42:05.791] Build status: STARTED
[20:42:05.791] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:29:0) after 8m17s
[20:50:22.817] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:29:0)
[20:50:22.847] Build status: STARTED
[20:50:22.847] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:30:0) after 3m52s
[20:54:14.863] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:30:0)
[20:54:14.883] Build status: STARTED
[20:54:14.883] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:31:0) after 5m48s
[21:00:02.911] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:31:0)
[21:00:03.313] Build status: STARTED
[21:00:03.313] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:32:0) after 6m49s
[21:06:52.341] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:32:0)
[21:06:52.361] Build status: STARTED
[21:06:52.361] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:33:0) after 9m51s
[21:16:43.591] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:33:0)
[21:16:43.629] Build status: STARTED
[21:16:43.629] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:34:0) after 1m0s
[21:17:43.672] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:34:0)
[21:17:43.703] Build status: STARTED
[21:17:43.703] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:35:0) after 7m0s
[21:24:43.735] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:35:0)
[21:24:43.760] Build status: STARTED
[21:24:43.760] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:36:0) after 4m42s
[21:29:25.879] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:36:0)
[21:29:25.915] Build status: STARTED
[21:29:25.915] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:37:0) after 5m47s
[21:35:12.886] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:37:0)
[21:35:12.908] Build status: STARTED
[21:35:12.908] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:38:0) after 9m47s
[21:44:59.930] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:38:0)
[21:44:59.953] Build status: STARTED
[21:44:59.953] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8900231885218505424:39:0) after 2m7s
[21:46:26.499] Received PubSub notification, asking Buildbucket for the build status
[21:46:26.529] Build:
{
"id": "8734801823288368689",
"builder": {
"project": "chromium",
"bucket": "build",
"builder": "linux-build-perf-siso"
},
"number": 2721,
"createdBy": "project:chromium",
"createTime": "2024-10-06T18:54:24.439144409Z",
"startTime": "2024-10-06T18:54:30.007511700Z",
"endTime": "2024-10-06T21:46:26.193401170Z",
"updateTime": "2024-10-06T21:46:26.193401170Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "2a6b132a2f85ee7aaafb1b6eb064d68823a65d43",
"ref": "refs/heads/main"
}
}
}
[21:46:26.529] Invocation finished in 2h52m3.313402724s with status SUCCEEDED