[08:34:36.462] New invocation is queued and will start shortly
[08:34:37.514] Starting the invocation (attempt 1)
[08:34:37.550] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/716ddb369e8956d342d1c00730fcf2a90e8707c4"
[08:34:37.550] Popped gitiles commit info from properties and tags
[08:34:37.550] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:34:37.550] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:34:37.550] Buildbucket request:
{
"requestId": "8934788322560477440",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "android-arm64-proguard-rel"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "716ddb369e8956d342d1c00730fcf2a90e8707c4",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8934788322560477440"
},
{
"key": "scheduler_job_id",
"value": "chromium/android-arm64-proguard-rel"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[08:34:38.320] Scheduled build:
{
"id": "8769358260707423377",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "android-arm64-proguard-rel"
},
"number": 9081,
"createdBy": "project:chromium",
"createTime": "2023-09-21T08:34:37.606780870Z",
"updateTime": "2023-09-21T08:34:37.606780870Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "716ddb369e8956d342d1c00730fcf2a90e8707c4",
"ref": "refs/heads/main"
}
}
}
[08:34:38.320] Task URL: https://cr-buildbucket.appspot.com/build/8769358260707423377
[08:34:38.320] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:2:0) after 3m35s
[08:34:39.410] Received PubSub notification, asking Buildbucket for the build status
[08:34:39.426] Build status: SCHEDULED
[08:34:40.827] Received PubSub notification, asking Buildbucket for the build status
[08:34:40.850] Build status: STARTED
[08:38:13.633] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:2:0)
[08:38:13.727] Build status: STARTED
[08:38:13.727] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:5:0) after 1m35s
[08:39:48.808] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:5:0)
[08:39:48.830] Build status: STARTED
[08:39:48.830] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:6:0) after 2m4s
[08:41:52.839] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:6:0)
[08:41:52.884] Build status: STARTED
[08:41:52.884] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:7:0) after 2m3s
[08:43:55.909] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:7:0)
[08:43:55.930] Build status: STARTED
[08:43:55.930] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:8:0) after 8m26s
[08:52:22.081] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:8:0)
[08:52:22.544] Build status: STARTED
[08:52:22.544] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:9:0) after 3m53s
[08:56:15.631] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:9:0)
[08:56:15.651] Build status: STARTED
[08:56:15.651] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:10:0) after 9m52s
[09:06:07.677] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:10:0)
[09:06:07.701] Build status: STARTED
[09:06:07.701] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:11:0) after 8m12s
[09:14:19.726] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:11:0)
[09:14:19.746] Build status: STARTED
[09:14:19.746] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:12:0) after 7m47s
[09:22:07.023] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:12:0)
[09:22:07.045] Build status: STARTED
[09:22:07.045] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:13:0) after 8m49s
[09:30:56.479] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:13:0)
[09:30:56.507] Build status: STARTED
[09:30:56.507] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:14:0) after 4m43s
[09:35:39.712] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:14:0)
[09:35:39.729] Build status: STARTED
[09:35:39.729] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:15:0) after 8m16s
[09:43:55.846] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:15:0)
[09:43:55.866] Build status: STARTED
[09:43:55.866] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:16:0) after 8m12s
[09:52:08.103] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:16:0)
[09:52:08.133] Build status: STARTED
[09:52:08.133] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:17:0) after 3m26s
[09:55:34.173] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:17:0)
[09:55:34.340] Build status: STARTED
[09:55:34.340] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:18:0) after 8m48s
[10:04:22.465] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:18:0)
[10:04:22.484] Build status: STARTED
[10:04:22.484] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:19:0) after 3m46s
[10:08:08.542] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:19:0)
[10:08:08.565] Build status: STARTED
[10:08:08.565] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:20:0) after 9m8s
[10:17:16.683] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:20:0)
[10:17:16.710] Build status: STARTED
[10:17:16.710] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:21:0) after 9m36s
[10:26:52.900] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:21:0)
[10:26:52.932] Build status: STARTED
[10:26:52.932] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:22:0) after 9m47s
[10:36:39.987] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:22:0)
[10:36:40.026] Build status: STARTED
[10:36:40.026] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:23:0) after 9m24s
[10:46:04.291] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:23:0)
[10:46:04.312] Build status: STARTED
[10:46:04.312] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:24:0) after 4m47s
[10:50:51.796] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:24:0)
[10:50:51.813] Build status: STARTED
[10:50:51.813] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:25:0) after 2m44s
[10:53:35.829] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:25:0)
[10:53:35.882] Build status: STARTED
[10:53:35.882] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:26:0) after 6m16s
[10:59:52.103] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:26:0)
[10:59:52.169] Build status: STARTED
[10:59:52.169] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:27:0) after 4m30s
[11:04:22.186] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:27:0)
[11:04:22.241] Build status: STARTED
[11:04:22.241] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:28:0) after 7m36s
[11:11:58.267] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:28:0)
[11:11:58.295] Build status: STARTED
[11:11:58.295] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:29:0) after 4m59s
[11:16:57.430] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:29:0)
[11:16:57.454] Build status: STARTED
[11:16:57.454] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:30:0) after 6m8s
[11:23:05.745] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:30:0)
[11:23:05.776] Build status: STARTED
[11:23:05.776] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:31:0) after 6m21s
[11:29:26.793] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:31:0)
[11:29:26.958] Build status: STARTED
[11:29:26.958] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:32:0) after 8m14s
[11:37:41.082] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:32:0)
[11:37:41.103] Build status: STARTED
[11:37:41.103] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:33:0) after 9m6s
[11:46:47.119] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:33:0)
[11:46:47.137] Build status: STARTED
[11:46:47.137] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:34:0) after 3m24s
[11:50:11.161] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:34:0)
[11:50:11.178] Build status: STARTED
[11:50:11.178] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:35:0) after 2m55s
[11:53:06.295] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:35:0)
[11:53:06.319] Build status: STARTED
[11:53:06.319] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:36:0) after 1m41s
[11:54:47.370] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:36:0)
[11:54:47.430] Build status: STARTED
[11:54:47.430] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:37:0) after 9m34s
[12:04:21.573] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:37:0)
[12:04:21.591] Build status: STARTED
[12:04:21.591] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:38:0) after 4m43s
[12:09:05.026] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:38:0)
[12:09:05.048] Build status: STARTED
[12:09:05.048] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:39:0) after 4m0s
[12:13:05.069] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:39:0)
[12:13:05.138] Build status: STARTED
[12:13:05.138] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:40:0) after 6m17s
[12:19:22.378] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:40:0)
[12:19:22.400] Build status: STARTED
[12:19:22.400] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:41:0) after 7m30s
[12:26:52.398] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:41:0)
[12:26:52.424] Build status: STARTED
[12:26:52.424] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:42:0) after 3m34s
[12:30:26.563] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:42:0)
[12:30:26.603] Build status: STARTED
[12:30:26.604] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:43:0) after 5m52s
[12:36:18.721] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:43:0)
[12:36:18.743] Build status: STARTED
[12:36:18.743] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:44:0) after 1m58s
[12:38:16.763] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:44:0)
[12:38:16.789] Build status: STARTED
[12:38:16.789] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:45:0) after 8m7s
[12:46:23.976] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:45:0)
[12:46:24.138] Build status: STARTED
[12:46:24.138] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:46:0) after 9m1s
[12:55:25.155] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:46:0)
[12:55:25.311] Build status: STARTED
[12:55:25.311] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:47:0) after 9m47s
[13:05:12.371] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:47:0)
[13:05:12.606] Build status: STARTED
[13:05:12.606] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:48:0) after 5m17s
[13:10:29.737] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:48:0)
[13:10:29.754] Build status: STARTED
[13:10:29.754] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:49:0) after 1m9s
[13:11:38.794] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:49:0)
[13:11:38.814] Build status: STARTED
[13:11:38.814] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:50:0) after 5m50s
[13:17:28.885] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:50:0)
[13:17:28.928] Build status: STARTED
[13:17:28.928] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:51:0) after 7m19s
[13:24:48.028] Handling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:51:0)
[13:24:48.047] Build status: STARTED
[13:24:48.047] Scheduling timer "check-buildbucket-build-status" (chromium/android-arm64-proguard-rel:8934788322560477440:52:0) after 1m23s
[13:26:04.991] Received PubSub notification, asking Buildbucket for the build status
[13:26:05.014] Build:
{
"id": "8769358260707423377",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "android-arm64-proguard-rel"
},
"number": 9081,
"createdBy": "project:chromium",
"createTime": "2023-09-21T08:34:37.606780870Z",
"startTime": "2023-09-21T08:34:40.151800Z",
"endTime": "2023-09-21T13:26:04.435861548Z",
"updateTime": "2023-09-21T13:26:04.435861548Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "716ddb369e8956d342d1c00730fcf2a90e8707c4",
"ref": "refs/heads/main"
}
}
}
[13:26:05.014] Invocation finished in 4h51m28.559147745s with status FAILED