[16:17:32.256] New invocation is queued and will start shortly
[16:17:33.327] Starting the invocation (attempt 1)
[16:17:33.364] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/58b37f770216cc031d4e592b035134b37fe643f8"
[16:17:33.364] Popped gitiles commit info from properties and tags
[16:17:33.364] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:17:33.364] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:17:33.364] Buildbucket request:
{
"requestId": "8908667271212012544",
"builder": {
"project": "chromium",
"bucket": "build",
"builder": "linux-build-perf-developer"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "58b37f770216cc031d4e592b035134b37fe643f8",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8908667271212012544"
},
{
"key": "scheduler_job_id",
"value": "chromium/linux-build-perf-developer"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[16:17:33.996] Scheduled build:
{
"id": "8743237209316274177",
"builder": {
"project": "chromium",
"bucket": "build",
"builder": "linux-build-perf-developer"
},
"number": 2684,
"createdBy": "project:chromium",
"createTime": "2024-07-05T16:17:33.435705626Z",
"updateTime": "2024-07-05T16:17:33.435705626Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "58b37f770216cc031d4e592b035134b37fe643f8",
"ref": "refs/heads/main"
}
}
}
[16:17:33.996] Task URL: https://cr-buildbucket.appspot.com/build/8743237209316274177
[16:17:33.996] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:2:0) after 2m7s
[16:17:34.977] Received PubSub notification, asking Buildbucket for the build status
[16:17:34.998] Build status: SCHEDULED
[16:18:50.631] Received PubSub notification, asking Buildbucket for the build status
[16:18:50.658] Build status: STARTED
[16:19:41.016] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:2:0)
[16:19:41.082] Build status: STARTED
[16:19:41.082] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:5:0) after 2m26s
[16:22:07.130] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:5:0)
[16:22:07.158] Build status: STARTED
[16:22:07.158] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:6:0) after 2m0s
[16:24:07.208] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:6:0)
[16:24:07.230] Build status: STARTED
[16:24:07.230] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:7:0) after 3m45s
[16:27:52.257] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:7:0)
[16:27:52.286] Build status: STARTED
[16:27:52.286] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:8:0) after 1m35s
[16:29:27.379] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:8:0)
[16:29:27.405] Build status: STARTED
[16:29:27.405] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:9:0) after 8m14s
[16:37:41.393] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:9:0)
[16:37:41.411] Build status: STARTED
[16:37:41.411] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:10:0) after 8m47s
[16:46:28.398] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:10:0)
[16:46:28.417] Build status: STARTED
[16:46:28.417] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:11:0) after 3m55s
[16:50:23.545] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:11:0)
[16:50:23.565] Build status: STARTED
[16:50:23.565] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:12:0) after 3m15s
[16:53:38.596] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:12:0)
[16:53:38.621] Build status: STARTED
[16:53:38.621] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:13:0) after 4m19s
[16:57:57.639] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:13:0)
[16:57:57.658] Build status: STARTED
[16:57:57.658] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:14:0) after 4m28s
[17:02:25.897] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:14:0)
[17:02:25.919] Build status: STARTED
[17:02:25.919] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:15:0) after 7m32s
[17:09:58.365] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:15:0)
[17:09:58.386] Build status: STARTED
[17:09:58.386] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:16:0) after 7m49s
[17:17:47.408] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:16:0)
[17:17:47.425] Build status: STARTED
[17:17:47.425] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:17:0) after 4m33s
[17:22:20.575] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:17:0)
[17:22:20.605] Build status: STARTED
[17:22:20.605] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:18:0) after 8m22s
[17:30:42.889] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:18:0)
[17:30:42.934] Build status: STARTED
[17:30:42.934] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:19:0) after 8m47s
[17:39:29.966] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:19:0)
[17:39:29.987] Build status: STARTED
[17:39:29.987] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:20:0) after 2m13s
[17:41:43.017] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:20:0)
[17:41:43.049] Build status: STARTED
[17:41:43.049] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:21:0) after 1m45s
[17:43:28.174] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:21:0)
[17:43:28.193] Build status: STARTED
[17:43:28.193] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:22:0) after 5m39s
[17:49:07.377] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:22:0)
[17:49:07.447] Build status: STARTED
[17:49:07.447] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:23:0) after 3m21s
[17:52:28.518] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:23:0)
[17:52:28.540] Build status: STARTED
[17:52:28.540] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:24:0) after 1m56s
[17:54:24.725] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:24:0)
[17:54:24.752] Build status: STARTED
[17:54:24.752] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:25:0) after 3m59s
[17:58:23.773] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:25:0)
[17:58:23.798] Build status: STARTED
[17:58:23.798] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:26:0) after 6m9s
[18:04:32.810] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:26:0)
[18:04:32.833] Build status: STARTED
[18:04:32.833] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:27:0) after 8m43s
[18:13:15.952] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:27:0)
[18:13:15.974] Build status: STARTED
[18:13:15.974] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:28:0) after 9m4s
[18:22:20.100] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:28:0)
[18:22:20.132] Build status: STARTED
[18:22:20.132] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:29:0) after 2m57s
[18:25:17.161] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:29:0)
[18:25:17.176] Build status: STARTED
[18:25:17.176] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:30:0) after 3m55s
[18:29:12.310] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:30:0)
[18:29:12.330] Build status: STARTED
[18:29:12.330] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:31:0) after 5m43s
[18:34:55.432] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:31:0)
[18:34:55.465] Build status: STARTED
[18:34:55.465] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:32:0) after 7m55s
[18:42:50.753] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:32:0)
[18:42:50.771] Build status: STARTED
[18:42:50.771] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:33:0) after 3m8s
[18:45:58.796] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:33:0)
[18:45:58.820] Build status: STARTED
[18:45:58.820] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:34:0) after 4m23s
[18:50:21.920] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:34:0)
[18:50:21.991] Build status: STARTED
[18:50:21.991] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:35:0) after 2m9s
[18:52:31.151] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:35:0)
[18:52:31.172] Build status: STARTED
[18:52:31.172] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:36:0) after 1m30s
[18:54:01.336] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:36:0)
[18:54:01.401] Build status: STARTED
[18:54:01.401] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:37:0) after 6m25s
[19:00:26.421] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:37:0)
[19:00:26.440] Build status: STARTED
[19:00:26.440] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:38:0) after 8m37s
[19:09:03.513] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:38:0)
[19:09:03.546] Build status: STARTED
[19:09:03.546] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:39:0) after 6m2s
[19:15:05.694] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:39:0)
[19:15:05.825] Build status: STARTED
[19:15:05.825] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:40:0) after 7m34s
[19:22:39.973] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:40:0)
[19:22:39.995] Build status: STARTED
[19:22:39.995] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:41:0) after 1m8s
[19:23:48.492] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:41:0)
[19:23:48.511] Build status: STARTED
[19:23:48.511] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:42:0) after 6m0s
[19:29:48.588] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:42:0)
[19:29:48.685] Build status: STARTED
[19:29:48.685] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:43:0) after 2m10s
[19:31:58.834] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:43:0)
[19:31:58.858] Build status: STARTED
[19:31:58.858] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:44:0) after 2m36s
[19:34:34.921] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:44:0)
[19:34:34.943] Build status: STARTED
[19:34:34.943] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:45:0) after 5m42s
[19:40:17.092] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:45:0)
[19:40:17.113] Build status: STARTED
[19:40:17.113] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:46:0) after 2m28s
[19:42:45.350] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:46:0)
[19:42:45.372] Build status: STARTED
[19:42:45.372] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:47:0) after 8m58s
[19:51:43.694] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:47:0)
[19:51:43.717] Build status: STARTED
[19:51:43.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:48:0) after 1m36s
[19:53:19.760] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:48:0)
[19:53:19.777] Build status: STARTED
[19:53:19.777] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:49:0) after 2m0s
[19:55:19.814] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:49:0)
[19:55:19.843] Build status: STARTED
[19:55:19.843] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:50:0) after 1m8s
[19:56:27.876] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:50:0)
[19:56:28.027] Build status: STARTED
[19:56:28.027] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:51:0) after 9m22s
[20:05:50.045] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:51:0)
[20:05:50.077] Build status: STARTED
[20:05:50.077] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:52:0) after 2m30s
[20:08:20.119] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:52:0)
[20:08:20.159] Build status: STARTED
[20:08:20.159] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:53:0) after 9m23s
[20:17:43.356] Handling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:53:0)
[20:17:43.378] Build status: STARTED
[20:17:43.378] Scheduling timer "check-buildbucket-build-status" (chromium/linux-build-perf-developer:8908667271212012544:54:0) after 7m4s
[20:18:03.076] Received PubSub notification, asking Buildbucket for the build status
[20:18:03.099] Build:
{
"id": "8743237209316274177",
"builder": {
"project": "chromium",
"bucket": "build",
"builder": "linux-build-perf-developer"
},
"number": 2684,
"createdBy": "project:chromium",
"createTime": "2024-07-05T16:17:33.435705626Z",
"startTime": "2024-07-05T16:18:50.461051280Z",
"endTime": "2024-07-05T20:18:01.329067116Z",
"updateTime": "2024-07-05T20:18:01.329067116Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "58b37f770216cc031d4e592b035134b37fe643f8",
"ref": "refs/heads/main"
}
}
}
[20:18:03.099] Invocation finished in 4h0m30.855121718s with status SUCCEEDED