[03:21:40.379] New invocation is queued and will start shortly
[03:21:41.503] Starting the invocation (attempt 1)
[03:21:41.524] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/acc6cebd25dd1a54c6ca63fc12955773b5b9bb77"
[03:21:41.524] Popped gitiles commit info from properties and tags
[03:21:41.524] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:21:41.524] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:21:41.524] Buildbucket request:
{
"requestId": "8925657717106887056",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "android-11-x86-rel"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "acc6cebd25dd1a54c6ca63fc12955773b5b9bb77",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8925657717106887056"
},
{
"key": "scheduler_job_id",
"value": "chromium/android-11-x86-rel"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[03:21:42.048] Scheduled build:
{
"id": "8760227655187344609",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "android-11-x86-rel"
},
"number": 10258,
"createdBy": "project:chromium",
"createTime": "2023-12-31T03:21:41.584995532Z",
"updateTime": "2023-12-31T03:21:41.584995532Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "acc6cebd25dd1a54c6ca63fc12955773b5b9bb77",
"ref": "refs/heads/main"
}
}
}
[03:21:42.048] Task URL: https://cr-buildbucket.appspot.com/build/8760227655187344609
[03:21:42.048] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:2:0) after 1m13s
[03:21:43.027] Received PubSub notification, asking Buildbucket for the build status
[03:21:43.054] Build status: SCHEDULED
[03:22:55.150] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:2:0)
[03:22:55.171] Build status: SCHEDULED
[03:22:55.171] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:4:0) after 5m28s
[03:28:23.302] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:4:0)
[03:28:23.319] Build status: SCHEDULED
[03:28:23.319] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:5:0) after 2m22s
[03:30:45.440] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:5:0)
[03:30:45.461] Build status: SCHEDULED
[03:30:45.461] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:6:0) after 1m3s
[03:31:48.480] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:6:0)
[03:31:48.502] Build status: SCHEDULED
[03:31:48.502] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:7:0) after 7m47s
[03:34:43.572] Received PubSub notification, asking Buildbucket for the build status
[03:34:43.614] Build status: STARTED
[03:39:35.694] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:7:0)
[03:39:35.716] Build status: STARTED
[03:39:35.716] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:9:0) after 8m0s
[03:47:35.838] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:9:0)
[03:47:35.859] Build status: STARTED
[03:47:35.859] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:10:0) after 1m4s
[03:48:40.064] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:10:0)
[03:48:40.199] Build status: STARTED
[03:48:40.199] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:11:0) after 2m58s
[03:51:38.213] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:11:0)
[03:51:38.290] Build status: STARTED
[03:51:38.290] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:12:0) after 6m39s
[03:58:17.304] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:12:0)
[03:58:17.328] Build status: STARTED
[03:58:17.329] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:13:0) after 6m8s
[04:04:25.312] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:13:0)
[04:04:25.332] Build status: STARTED
[04:04:25.332] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:14:0) after 9m24s
[04:13:49.376] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:14:0)
[04:13:49.444] Build status: STARTED
[04:13:49.444] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:15:0) after 3m7s
[04:16:56.571] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:15:0)
[04:16:56.608] Build status: STARTED
[04:16:56.608] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:16:0) after 7m46s
[04:24:42.721] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:16:0)
[04:24:42.736] Build status: STARTED
[04:24:42.736] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:17:0) after 9m31s
[04:34:13.749] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:17:0)
[04:34:13.767] Build status: STARTED
[04:34:13.767] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:18:0) after 5m0s
[04:39:13.789] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:18:0)
[04:39:13.809] Build status: STARTED
[04:39:13.809] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:19:0) after 3m5s
[04:42:18.868] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:19:0)
[04:42:18.894] Build status: STARTED
[04:42:18.894] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:20:0) after 6m26s
[04:48:44.917] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:20:0)
[04:48:44.945] Build status: STARTED
[04:48:44.945] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:21:0) after 2m1s
[04:50:45.959] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:21:0)
[04:50:45.978] Build status: STARTED
[04:50:45.978] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:22:0) after 5m49s
[04:56:34.997] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:22:0)
[04:56:35.020] Build status: STARTED
[04:56:35.020] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:23:0) after 2m23s
[04:58:58.032] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:23:0)
[04:58:58.063] Build status: STARTED
[04:58:58.063] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:24:0) after 1m0s
[04:59:58.077] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:24:0)
[04:59:58.093] Build status: STARTED
[04:59:58.094] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:25:0) after 9m41s
[05:09:39.113] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:25:0)
[05:09:39.129] Build status: STARTED
[05:09:39.129] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:26:0) after 5m55s
[05:15:34.195] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:26:0)
[05:15:34.232] Build status: STARTED
[05:15:34.232] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:27:0) after 2m14s
[05:17:48.247] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:27:0)
[05:17:48.283] Build status: STARTED
[05:17:48.283] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:28:0) after 7m59s
[05:25:47.399] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:28:0)
[05:25:47.418] Build status: STARTED
[05:25:47.418] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:29:0) after 3m40s
[05:29:27.439] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:29:0)
[05:29:27.565] Build status: STARTED
[05:29:27.565] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:30:0) after 7m50s
[05:37:17.657] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:30:0)
[05:37:17.673] Build status: STARTED
[05:37:17.673] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:31:0) after 5m0s
[05:42:17.685] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:31:0)
[05:42:17.700] Build status: STARTED
[05:42:17.700] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:32:0) after 7m6s
[05:49:23.811] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:32:0)
[05:49:23.838] Build status: STARTED
[05:49:23.838] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:33:0) after 4m14s
[05:53:37.850] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:33:0)
[05:53:37.867] Build status: STARTED
[05:53:37.867] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:34:0) after 4m53s
[05:58:30.905] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:34:0)
[05:58:30.927] Build status: STARTED
[05:58:30.927] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:35:0) after 7m4s
[06:05:35.041] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:35:0)
[06:05:35.058] Build status: STARTED
[06:05:35.058] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:36:0) after 1m43s
[06:07:18.078] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:36:0)
[06:07:18.098] Build status: STARTED
[06:07:18.098] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:37:0) after 1m18s
[06:08:36.118] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:37:0)
[06:08:36.137] Build status: STARTED
[06:08:36.137] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:38:0) after 4m10s
[06:12:46.175] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:38:0)
[06:12:46.197] Build status: STARTED
[06:12:46.197] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:39:0) after 4m56s
[06:17:42.200] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:39:0)
[06:17:42.220] Build status: STARTED
[06:17:42.220] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:40:0) after 2m32s
[06:20:14.240] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:40:0)
[06:20:14.259] Build status: STARTED
[06:20:14.259] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:41:0) after 9m56s
[06:30:10.276] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:41:0)
[06:30:10.397] Build status: STARTED
[06:30:10.397] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:42:0) after 5m31s
[06:35:41.425] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:42:0)
[06:35:41.454] Build status: STARTED
[06:35:41.454] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8925657717106887056:43:0) after 2m30s
[06:36:36.024] Received PubSub notification, asking Buildbucket for the build status
[06:36:36.189] Build:
{
"id": "8760227655187344609",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "android-11-x86-rel"
},
"number": 10258,
"createdBy": "project:chromium",
"createTime": "2023-12-31T03:21:41.584995532Z",
"startTime": "2023-12-31T03:34:42.249772Z",
"endTime": "2023-12-31T06:36:34.859577Z",
"updateTime": "2023-12-31T06:36:34.859577Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "acc6cebd25dd1a54c6ca63fc12955773b5b9bb77",
"ref": "refs/heads/main"
}
}
}
[06:36:36.189] Invocation finished in 3h14m55.820318886s with status SUCCEEDED