[19:36:22.909] New invocation is queued and will start shortly
[19:36:24.039] Starting the invocation (attempt 1)
[19:36:24.075] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a83ba4821f7e18be1516987d3f75d1e08fe9a035"
[19:36:24.075] Popped gitiles commit info from properties and tags
[19:36:24.075] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:36:24.075] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:36:24.075] Buildbucket request:
{
"requestId": "8908382970111517936",
"builder": {
"project": "chromium",
"bucket": "build",
"builder": "linux-build-perf-siso"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "a83ba4821f7e18be1516987d3f75d1e08fe9a035",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8908382970111517936"
},
{
"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"
}
}
[19:36:24.855] Scheduled build:
{
"id": "8742952908164312577",
"builder": {
"project": "chromium",
"bucket": "build",
"builder": "linux-build-perf-siso"
},
"number": 1447,
"createdBy": "project:chromium",
"createTime": "2024-07-08T19:36:24.142008018Z",
"updateTime": "2024-07-08T19:36:24.142008018Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "a83ba4821f7e18be1516987d3f75d1e08fe9a035",
"ref": "refs/heads/main"
}
}
}
[19:36:24.856] Task URL: https://cr-buildbucket.appspot.com/build/8742952908164312577
[19:36:24.856] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:2:0) after 2m16s
[19:36:58.107] Received PubSub notification, asking Buildbucket for the build status
[19:36:58.145] Build status: STARTED
[19:37:03.859] Received PubSub notification, asking Buildbucket for the build status
[19:37:03.950] Build status: STARTED
[19:38:41.032] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:2:0)
[19:38:41.057] Build status: STARTED
[19:38:41.057] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:5:0) after 2m13s
[19:40:54.076] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:5:0)
[19:40:54.175] Build status: STARTED
[19:40:54.175] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:6:0) after 2m13s
[19:43:07.225] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:6:0)
[19:43:07.243] Build status: STARTED
[19:43:07.243] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:7:0) after 6m58s
[19:50:06.732] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:7:0)
[19:50:06.766] Build status: STARTED
[19:50:06.766] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:8:0) after 2m19s
[19:52:25.881] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:8:0)
[19:52:25.907] Build status: STARTED
[19:52:25.907] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:9:0) after 9m38s
[20:02:03.934] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:9:0)
[20:02:03.963] Build status: STARTED
[20:02:03.963] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:10:0) after 9m42s
[20:11:46.042] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:10:0)
[20:11:46.089] Build status: STARTED
[20:11:46.089] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:11:0) after 6m10s
[20:17:56.130] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:11:0)
[20:17:56.149] Build status: STARTED
[20:17:56.149] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:12:0) after 1m49s
[20:19:45.216] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:12:0)
[20:19:45.232] Build status: STARTED
[20:19:45.232] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:13:0) after 5m42s
[20:25:27.257] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:13:0)
[20:25:27.276] Build status: STARTED
[20:25:27.276] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:14:0) after 3m3s
[20:28:30.397] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:14:0)
[20:28:30.442] Build status: STARTED
[20:28:30.442] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:15:0) after 9m56s
[20:38:26.489] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:15:0)
[20:38:26.545] Build status: STARTED
[20:38:26.545] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:16:0) after 6m20s
[20:44:46.571] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:16:0)
[20:44:46.664] Build status: STARTED
[20:44:46.664] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:17:0) after 7m27s
[20:52:13.686] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:17:0)
[20:52:13.713] Build status: STARTED
[20:52:13.713] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:18:0) after 4m48s
[20:57:01.733] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:18:0)
[20:57:01.753] Build status: STARTED
[20:57:01.753] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:19:0) after 3m30s
[21:00:31.771] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:19:0)
[21:00:31.803] Build status: STARTED
[21:00:31.803] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:20:0) after 1m35s
[21:02:06.868] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:20:0)
[21:02:06.931] Build status: STARTED
[21:02:06.931] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:21:0) after 3m53s
[21:05:59.955] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:21:0)
[21:06:00.135] Build status: STARTED
[21:06:00.135] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:22:0) after 1m32s
[21:07:32.128] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:22:0)
[21:07:32.237] Build status: STARTED
[21:07:32.237] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:23:0) after 1m45s
[21:09:17.267] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:23:0)
[21:09:17.291] Build status: STARTED
[21:09:17.291] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:24:0) after 6m10s
[21:15:27.310] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:24:0)
[21:15:27.334] Build status: STARTED
[21:15:27.334] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:25:0) after 8m6s
[21:23:33.354] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:25:0)
[21:23:33.402] Build status: STARTED
[21:23:33.402] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:26:0) after 1m51s
[21:25:24.436] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:26:0)
[21:25:24.479] Build status: STARTED
[21:25:24.479] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:27:0) after 5m39s
[21:31:03.497] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:27:0)
[21:31:03.515] Build status: STARTED
[21:31:03.515] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:28:0) after 3m1s
[21:34:04.535] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:28:0)
[21:34:04.554] Build status: STARTED
[21:34:04.554] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:29:0) after 4m45s
[21:38:49.551] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:29:0)
[21:38:49.569] Build status: STARTED
[21:38:49.569] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:30:0) after 9m38s
[21:48:27.585] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:30:0)
[21:48:27.650] Build status: STARTED
[21:48:27.650] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:31:0) after 1m0s
[21:49:27.671] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:31:0)
[21:49:27.689] Build status: STARTED
[21:49:27.689] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:32:0) after 5m39s
[21:55:06.713] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:32:0)
[21:55:06.744] Build status: STARTED
[21:55:06.744] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:33:0) after 7m51s
[22:02:57.771] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:33:0)
[22:02:57.813] Build status: STARTED
[22:02:57.813] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:34:0) after 4m25s
[22:07:23.352] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:34:0)
[22:07:23.369] Build status: STARTED
[22:07:23.369] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:35:0) after 5m10s
[22:12:34.036] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:35:0)
[22:12:34.054] Build status: STARTED
[22:12:34.054] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:36:0) after 2m7s
[22:14:41.105] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:36:0)
[22:14:41.134] Build status: STARTED
[22:14:41.134] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:37:0) after 1m7s
[22:15:48.202] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:37:0)
[22:15:48.228] Build status: STARTED
[22:15:48.228] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-siso:8908382970111517936:38:0) after 5m43s
[22:17:40.579] Received PubSub notification, asking Buildbucket for the build status
[22:17:40.596] Build:
{
"id": "8742952908164312577",
"builder": {
"project": "chromium",
"bucket": "build",
"builder": "linux-build-perf-siso"
},
"number": 1447,
"createdBy": "project:chromium",
"createTime": "2024-07-08T19:36:24.142008018Z",
"startTime": "2024-07-08T19:36:30.033435707Z",
"endTime": "2024-07-08T22:17:40.125210683Z",
"updateTime": "2024-07-08T22:17:40.125210683Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "a83ba4821f7e18be1516987d3f75d1e08fe9a035",
"ref": "refs/heads/main"
}
}
}
[22:17:40.596] Invocation finished in 2h41m17.695311362s with status SUCCEEDED