[16:54:32.766] New invocation is queued and will start shortly
[16:54:34.390] Starting the invocation (attempt 1)
[16:54:34.428] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6f75aac5df224292412188ae26dc20b6f5c87d24"
[16:54:34.428] Popped gitiles commit info from properties and tags
[16:54:34.428] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:54:34.428] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:54:34.429] Buildbucket request:
{
"requestId": "8904316288450373216",
"builder": {
"project": "chromium",
"bucket": "build",
"builder": "android-build-perf-developer"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "6f75aac5df224292412188ae26dc20b6f5c87d24",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8904316288450373216"
},
{
"key": "scheduler_job_id",
"value": "chromium/android-build-perf-developer"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[16:54:35.047] Scheduled build:
{
"id": "8738886225980467441",
"builder": {
"project": "chromium",
"bucket": "build",
"builder": "android-build-perf-developer"
},
"number": 2266,
"createdBy": "project:chromium",
"createTime": "2024-08-22T16:54:34.494157809Z",
"updateTime": "2024-08-22T16:54:34.494157809Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "6f75aac5df224292412188ae26dc20b6f5c87d24",
"ref": "refs/heads/main"
}
}
}
[16:54:35.048] Task URL: https://cr-buildbucket.appspot.com/build/8738886225980467441
[16:54:35.048] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:2:0) after 3m30s
[16:54:56.696] Received PubSub notification, asking Buildbucket for the build status
[16:54:56.713] Build status: SCHEDULED
[16:55:28.023] Received PubSub notification, asking Buildbucket for the build status
[16:55:28.041] Build status: STARTED
[16:58:05.170] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:2:0)
[16:58:05.191] Build status: STARTED
[16:58:05.191] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:5:0) after 9m13s
[17:07:18.211] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:5:0)
[17:07:18.231] Build status: STARTED
[17:07:18.233] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:6:0) after 8m33s
[17:15:51.250] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:6:0)
[17:15:51.269] Build status: STARTED
[17:15:51.269] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:7:0) after 3m51s
[17:19:42.245] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:7:0)
[17:19:42.271] Build status: STARTED
[17:19:42.272] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:8:0) after 5m8s
[17:24:50.290] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:8:0)
[17:24:50.319] Build status: STARTED
[17:24:50.319] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:9:0) after 7m25s
[17:32:15.349] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:9:0)
[17:32:15.371] Build status: STARTED
[17:32:15.371] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:10:0) after 4m32s
[17:36:47.387] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:10:0)
[17:36:47.406] Build status: STARTED
[17:36:47.406] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:11:0) after 2m20s
[17:39:07.425] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:11:0)
[17:39:07.454] Build status: STARTED
[17:39:07.454] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:12:0) after 7m42s
[17:46:49.495] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:12:0)
[17:46:49.521] Build status: STARTED
[17:46:49.521] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:13:0) after 3m50s
[17:50:39.586] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:13:0)
[17:50:39.682] Build status: STARTED
[17:50:39.682] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:14:0) after 4m15s
[17:54:54.741] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:14:0)
[17:54:54.762] Build status: STARTED
[17:54:54.762] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:15:0) after 7m2s
[18:01:56.778] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:15:0)
[18:01:56.797] Build status: STARTED
[18:01:56.797] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:16:0) after 8m5s
[18:10:01.817] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:16:0)
[18:10:01.852] Build status: STARTED
[18:10:01.852] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:17:0) after 8m10s
[18:18:11.845] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:17:0)
[18:18:11.941] Build status: STARTED
[18:18:11.941] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:18:0) after 8m54s
[18:27:05.995] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:18:0)
[18:27:06.013] Build status: STARTED
[18:27:06.013] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:19:0) after 5m7s
[18:32:13.027] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:19:0)
[18:32:13.045] Build status: STARTED
[18:32:13.045] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:20:0) after 1m28s
[18:33:41.113] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:20:0)
[18:33:41.134] Build status: STARTED
[18:33:41.134] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:21:0) after 5m29s
[18:39:10.151] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:21:0)
[18:39:10.165] Build status: STARTED
[18:39:10.165] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:22:0) after 2m47s
[18:41:57.416] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:22:0)
[18:41:57.437] Build status: STARTED
[18:41:57.437] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:23:0) after 7m33s
[18:49:30.471] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:23:0)
[18:49:30.573] Build status: STARTED
[18:49:30.573] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:24:0) after 8m31s
[18:58:01.643] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:24:0)
[18:58:01.669] Build status: STARTED
[18:58:01.669] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:25:0) after 2m28s
[19:00:29.723] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:25:0)
[19:00:29.761] Build status: STARTED
[19:00:29.761] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:26:0) after 8m10s
[19:08:39.778] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:26:0)
[19:08:39.799] Build status: STARTED
[19:08:39.799] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:27:0) after 4m6s
[19:12:45.852] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:27:0)
[19:12:45.872] Build status: STARTED
[19:12:45.872] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:28:0) after 1m5s
[19:13:50.882] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:28:0)
[19:13:50.908] Build status: STARTED
[19:13:50.908] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:29:0) after 6m26s
[19:20:16.925] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:29:0)
[19:20:16.990] Build status: STARTED
[19:20:16.990] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:30:0) after 2m58s
[19:23:15.009] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:30:0)
[19:23:15.028] Build status: STARTED
[19:23:15.028] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:31:0) after 2m21s
[19:25:36.052] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:31:0)
[19:25:36.072] Build status: STARTED
[19:25:36.072] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:32:0) after 3m37s
[19:29:13.118] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:32:0)
[19:29:13.322] Build status: STARTED
[19:29:13.322] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:33:0) after 4m51s
[19:34:04.343] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:33:0)
[19:34:04.411] Build status: STARTED
[19:34:04.411] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:34:0) after 4m53s
[19:38:57.467] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:34:0)
[19:38:57.485] Build status: STARTED
[19:38:57.485] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:35:0) after 7m17s
[19:46:14.518] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:35:0)
[19:46:14.583] Build status: STARTED
[19:46:14.583] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:36:0) after 4m18s
[19:50:32.607] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:36:0)
[19:50:32.623] Build status: STARTED
[19:50:32.623] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:37:0) after 6m21s
[19:56:53.676] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:37:0)
[19:56:53.692] Build status: STARTED
[19:56:53.692] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:38:0) after 6m12s
[20:03:05.745] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:38:0)
[20:03:05.778] Build status: STARTED
[20:03:05.778] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:39:0) after 2m35s
[20:05:40.804] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:39:0)
[20:05:40.829] Build status: STARTED
[20:05:40.829] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:40:0) after 2m37s
[20:08:17.859] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:40:0)
[20:08:17.875] Build status: STARTED
[20:08:17.876] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:41:0) after 9m59s
[20:18:16.962] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:41:0)
[20:18:16.981] Build status: STARTED
[20:18:16.981] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:42:0) after 2m20s
[20:20:36.949] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:42:0)
[20:20:37.011] Build status: STARTED
[20:20:37.011] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:43:0) after 5m50s
[20:26:27.033] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:43:0)
[20:26:27.119] Build status: STARTED
[20:26:27.119] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:44:0) after 9m19s
[20:35:46.239] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:44:0)
[20:35:46.270] Build status: STARTED
[20:35:46.270] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:45:0) after 5m1s
[20:40:47.295] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:45:0)
[20:40:47.313] Build status: STARTED
[20:40:47.313] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:46:0) after 2m10s
[20:42:57.332] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:46:0)
[20:42:57.354] Build status: STARTED
[20:42:57.354] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:47:0) after 1m9s
[20:44:06.560] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:47:0)
[20:44:06.583] Build status: STARTED
[20:44:06.583] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:48:0) after 2m25s
[20:46:33.091] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:48:0)
[20:46:33.110] Build status: STARTED
[20:46:33.110] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:49:0) after 3m50s
[20:50:23.148] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:49:0)
[20:50:23.184] Build status: STARTED
[20:50:23.184] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:50:0) after 2m23s
[20:52:46.189] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:50:0)
[20:52:46.210] Build status: STARTED
[20:52:46.210] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:51:0) after 5m53s
[20:58:39.277] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:51:0)
[20:58:39.295] Build status: STARTED
[20:58:39.295] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:52:0) after 2m5s
[21:00:44.278] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:52:0)
[21:00:44.307] Build status: STARTED
[21:00:44.307] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:53:0) after 9m17s
[21:10:01.312] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:53:0)
[21:10:01.333] Build status: STARTED
[21:10:01.333] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:54:0) after 6m39s
[21:16:40.364] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:54:0)
[21:16:40.388] Build status: STARTED
[21:16:40.388] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8904316288450373216:55:0) after 7m14s
[21:18:04.689] Received PubSub notification, asking Buildbucket for the build status
[21:18:04.708] Build:
{
"id": "8738886225980467441",
"builder": {
"project": "chromium",
"bucket": "build",
"builder": "android-build-perf-developer"
},
"number": 2266,
"createdBy": "project:chromium",
"createTime": "2024-08-22T16:54:34.494157809Z",
"startTime": "2024-08-22T16:55:13.328017114Z",
"endTime": "2024-08-22T21:18:03.442841431Z",
"updateTime": "2024-08-22T21:18:03.442841431Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "6f75aac5df224292412188ae26dc20b6f5c87d24",
"ref": "refs/heads/main"
}
}
}
[21:18:04.708] Invocation finished in 4h23m31.952799067s with status SUCCEEDED