[12:55:39.191] New invocation is queued and will start shortly
[12:55:40.244] Starting the invocation (attempt 1)
[12:55:40.282] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6caae65fa63ab812211e3dd24fa8bf896608de89"
[12:55:40.282] Popped gitiles commit info from properties and tags
[12:55:40.282] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:55:40.283] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:55:40.283] Buildbucket request:
{
"requestId": "9003263205605594080",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "android-12-x64-fyi-rel"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "6caae65fa63ab812211e3dd24fa8bf896608de89",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9003263205605594080"
},
{
"key": "scheduler_job_id",
"value": "chromium/android-12-x64-fyi-rel"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[12:55:40.823] Scheduled build:
{
"id": "8837833143707507057",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "android-12-x64-fyi-rel"
},
"number": 640,
"createdBy": "project:chromium",
"createTime": "2021-08-26T12:55:40.370487445Z",
"updateTime": "2021-08-26T12:55:40.640259211Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "6caae65fa63ab812211e3dd24fa8bf896608de89",
"ref": "refs/heads/main"
}
}
}
[12:55:40.823] Task URL: https://cr-buildbucket.appspot.com/build/8837833143707507057
[12:55:40.823] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:2:0) after 8m27s
[12:55:56.320] Received PubSub notification, asking Buildbucket for the build status
[12:55:56.351] Build status: STARTED
[13:04:07.982] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:2:0)
[13:04:08.283] Build status: STARTED
[13:04:08.283] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:4:0) after 6m31s
[13:10:39.272] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:4:0)
[13:10:39.303] Build status: STARTED
[13:10:39.303] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:5:0) after 2m9s
[13:12:48.326] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:5:0)
[13:12:48.399] Build status: STARTED
[13:12:48.399] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:6:0) after 4m1s
[13:16:49.469] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:6:0)
[13:16:49.495] Build status: STARTED
[13:16:49.495] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:7:0) after 8m43s
[13:25:32.513] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:7:0)
[13:25:32.565] Build status: STARTED
[13:25:32.565] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:8:0) after 9m3s
[13:34:35.607] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:8:0)
[13:34:35.780] Build status: STARTED
[13:34:35.780] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:9:0) after 8m45s
[13:43:20.808] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:9:0)
[13:43:20.848] Build status: STARTED
[13:43:20.848] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:10:0) after 8m8s
[13:51:29.062] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:10:0)
[13:51:29.121] Build status: STARTED
[13:51:29.121] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:11:0) after 6m10s
[13:57:39.141] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:11:0)
[13:57:39.179] Build status: STARTED
[13:57:39.179] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:12:0) after 9m19s
[14:06:58.281] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:12:0)
[14:06:58.312] Build status: STARTED
[14:06:58.312] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:13:0) after 9m18s
[14:16:16.512] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:13:0)
[14:16:16.594] Build status: STARTED
[14:16:16.594] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:14:0) after 2m31s
[14:18:47.616] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:14:0)
[14:18:47.664] Build status: STARTED
[14:18:47.664] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:15:0) after 1m31s
[14:20:18.869] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:15:0)
[14:20:19.014] Build status: STARTED
[14:20:19.014] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:16:0) after 3m26s
[14:23:45.077] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:16:0)
[14:23:45.150] Build status: STARTED
[14:23:45.150] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:17:0) after 6m5s
[14:29:50.286] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:17:0)
[14:29:50.387] Build status: STARTED
[14:29:50.387] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:18:0) after 3m53s
[14:33:43.411] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:18:0)
[14:33:43.441] Build status: STARTED
[14:33:43.441] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:19:0) after 5m1s
[14:38:44.520] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:19:0)
[14:38:44.553] Build status: STARTED
[14:38:44.553] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:20:0) after 2m20s
[14:41:04.640] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:20:0)
[14:41:04.687] Build status: STARTED
[14:41:04.687] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:21:0) after 4m16s
[14:45:20.713] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:21:0)
[14:45:20.985] Build status: STARTED
[14:45:20.985] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:22:0) after 2m1s
[14:47:22.156] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:22:0)
[14:47:22.198] Build status: STARTED
[14:47:22.198] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:23:0) after 1m25s
[14:48:47.346] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:23:0)
[14:48:47.386] Build status: STARTED
[14:48:47.386] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:24:0) after 7m40s
[14:56:27.447] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:24:0)
[14:56:27.474] Build status: STARTED
[14:56:27.474] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:25:0) after 8m16s
[15:04:43.500] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:25:0)
[15:04:43.531] Build status: STARTED
[15:04:43.531] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:26:0) after 5m37s
[15:10:20.585] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:26:0)
[15:10:20.619] Build status: STARTED
[15:10:20.619] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:27:0) after 5m35s
[15:15:55.960] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:27:0)
[15:15:56.006] Build status: STARTED
[15:15:56.006] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:28:0) after 4m46s
[15:20:42.159] Handling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:28:0)
[15:20:42.263] Build status: STARTED
[15:20:42.263] Scheduling timer "check-buildbucket-build-status" (chromium/android-12-x64-fyi-rel:9003263205605594080:29:0) after 9m4s
[15:29:05.359] Received PubSub notification, asking Buildbucket for the build status
[15:29:05.464] Build:
{
"id": "8837833143707507057",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "android-12-x64-fyi-rel"
},
"number": 640,
"createdBy": "project:chromium",
"createTime": "2021-08-26T12:55:40.370487445Z",
"startTime": "2021-08-26T12:55:55.698833Z",
"endTime": "2021-08-26T15:29:02.478442876Z",
"updateTime": "2021-08-26T15:29:02.479384103Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "6caae65fa63ab812211e3dd24fa8bf896608de89",
"ref": "refs/heads/main"
}
}
}
[15:29:05.464] Invocation finished in 2h33m26.287582324s with status FAILED