[18:50:10.127] New invocation is queued and will start shortly
[18:50:11.268] Starting the invocation (attempt 1)
[18:50:11.307] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/67aacac5158836027fa275a629502e166c78f70b"
[18:50:11.307] Popped gitiles commit info from properties and tags
[18:50:11.307] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:50:11.308] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:50:11.308] Buildbucket request:
{
"requestId": "8967455099679604640",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "android-11-x86-rel"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "67aacac5158836027fa275a629502e166c78f70b",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8967455099679604640"
},
{
"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"
}
}
[18:50:11.866] Scheduled build:
{
"id": "8802025037610191745",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "android-11-x86-rel"
},
"number": 4990,
"createdBy": "project:chromium",
"createTime": "2022-09-25T18:50:11.474395001Z",
"updateTime": "2022-09-25T18:50:11.474395001Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "67aacac5158836027fa275a629502e166c78f70b",
"ref": "refs/heads/main"
}
}
}
[18:50:11.866] Task URL: https://cr-buildbucket.appspot.com/build/8802025037610191745
[18:50:11.866] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:2:0) after 4m57s
[18:55:08.893] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:2:0)
[18:55:08.930] Build status: SCHEDULED
[18:55:08.930] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:3:0) after 2m51s
[18:55:33.133] Received PubSub notification, asking Buildbucket for the build status
[18:55:33.155] Build status: STARTED
[18:57:59.957] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:3:0)
[18:57:59.980] Build status: STARTED
[18:57:59.980] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:5:0) after 4m52s
[19:02:52.002] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:5:0)
[19:02:52.025] Build status: STARTED
[19:02:52.025] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:6:0) after 2m24s
[19:05:16.055] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:6:0)
[19:05:16.081] Build status: STARTED
[19:05:16.081] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:7:0) after 1m46s
[19:07:02.278] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:7:0)
[19:07:02.310] Build status: STARTED
[19:07:02.310] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:8:0) after 3m8s
[19:10:10.389] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:8:0)
[19:10:10.420] Build status: STARTED
[19:10:10.420] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:9:0) after 3m22s
[19:13:32.444] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:9:0)
[19:13:32.474] Build status: STARTED
[19:13:32.474] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:10:0) after 1m8s
[19:14:40.503] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:10:0)
[19:14:40.541] Build status: STARTED
[19:14:40.541] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:11:0) after 2m24s
[19:17:04.601] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:11:0)
[19:17:04.624] Build status: STARTED
[19:17:04.624] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:12:0) after 2m43s
[19:19:47.670] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:12:0)
[19:19:47.796] Build status: STARTED
[19:19:47.796] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:13:0) after 6m4s
[19:25:51.823] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:13:0)
[19:25:51.856] Build status: STARTED
[19:25:51.856] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:14:0) after 1m18s
[19:27:09.879] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:14:0)
[19:27:09.902] Build status: STARTED
[19:27:09.902] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:15:0) after 9m3s
[19:36:12.925] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:15:0)
[19:36:12.976] Build status: STARTED
[19:36:12.976] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:16:0) after 7m27s
[19:43:39.966] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:16:0)
[19:43:39.987] Build status: STARTED
[19:43:39.987] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:17:0) after 2m37s
[19:46:17.006] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:17:0)
[19:46:17.029] Build status: STARTED
[19:46:17.029] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:18:0) after 4m56s
[19:51:13.133] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:18:0)
[19:51:13.156] Build status: STARTED
[19:51:13.156] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:19:0) after 6m2s
[19:57:15.232] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:19:0)
[19:57:15.297] Build status: STARTED
[19:57:15.297] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:20:0) after 4m54s
[20:02:09.324] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:20:0)
[20:02:09.350] Build status: STARTED
[20:02:09.350] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:21:0) after 9m19s
[20:11:28.476] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:21:0)
[20:11:28.503] Build status: STARTED
[20:11:28.503] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:22:0) after 2m12s
[20:13:40.750] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:22:0)
[20:13:40.777] Build status: STARTED
[20:13:40.777] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:23:0) after 7m4s
[20:20:44.889] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:23:0)
[20:20:44.961] Build status: STARTED
[20:20:44.961] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:24:0) after 2m11s
[20:22:56.055] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:24:0)
[20:22:56.082] Build status: STARTED
[20:22:56.082] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:25:0) after 3m23s
[20:26:19.106] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:25:0)
[20:26:19.138] Build status: STARTED
[20:26:19.138] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:26:0) after 3m19s
[20:29:38.258] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:26:0)
[20:29:38.285] Build status: STARTED
[20:29:38.285] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:27:0) after 3m24s
[20:33:02.318] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:27:0)
[20:33:02.343] Build status: STARTED
[20:33:02.343] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:28:0) after 9m55s
[20:42:57.515] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:28:0)
[20:42:57.540] Build status: STARTED
[20:42:57.540] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:29:0) after 6m28s
[20:49:25.561] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:29:0)
[20:49:25.582] Build status: STARTED
[20:49:25.582] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:30:0) after 2m3s
[20:51:28.612] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:30:0)
[20:51:28.637] Build status: STARTED
[20:51:28.637] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:31:0) after 8m6s
[20:59:34.773] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:31:0)
[20:59:34.797] Build status: STARTED
[20:59:34.797] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:32:0) after 2m45s
[21:02:19.836] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:32:0)
[21:02:19.863] Build status: STARTED
[21:02:19.863] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:33:0) after 3m19s
[21:05:38.934] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:33:0)
[21:05:38.959] Build status: STARTED
[21:05:38.959] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:34:0) after 4m17s
[21:09:55.982] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:34:0)
[21:09:56.080] Build status: STARTED
[21:09:56.080] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:35:0) after 1m51s
[21:11:47.110] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:35:0)
[21:11:47.140] Build status: STARTED
[21:11:47.140] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:36:0) after 4m50s
[21:16:37.162] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:36:0)
[21:16:37.188] Build status: STARTED
[21:16:37.188] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:37:0) after 6m51s
[21:23:28.735] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:37:0)
[21:23:28.759] Build status: STARTED
[21:23:28.759] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:38:0) after 8m12s
[21:31:40.780] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:38:0)
[21:31:40.805] Build status: STARTED
[21:31:40.805] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:39:0) after 7m23s
[21:39:03.862] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:39:0)
[21:39:03.885] Build status: STARTED
[21:39:03.885] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:40:0) after 2m8s
[21:41:11.907] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:40:0)
[21:41:11.929] Build status: STARTED
[21:41:11.929] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:41:0) after 2m11s
[21:43:22.950] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:41:0)
[21:43:22.971] Build status: STARTED
[21:43:22.971] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:42:0) after 3m10s
[21:46:32.991] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:42:0)
[21:46:33.015] Build status: STARTED
[21:46:33.015] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:43:0) after 3m52s
[21:50:25.088] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:43:0)
[21:50:25.110] Build status: STARTED
[21:50:25.110] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:44:0) after 1m55s
[21:52:20.131] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:44:0)
[21:52:20.157] Build status: STARTED
[21:52:20.157] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:45:0) after 2m59s
[21:55:19.387] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:45:0)
[21:55:19.407] Build status: STARTED
[21:55:19.407] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:46:0) after 1m1s
[21:56:20.555] Handling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:46:0)
[21:56:20.579] Build status: STARTED
[21:56:20.579] Scheduling timer "check-buildbucket-build-status" (chromium/android-11-x86-rel:8967455099679604640:47:0) after 5m24s
[22:00:13.044] Received PubSub notification, asking Buildbucket for the build status
[22:00:13.073] Build:
{
"id": "8802025037610191745",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "android-11-x86-rel"
},
"number": 4990,
"createdBy": "project:chromium",
"createTime": "2022-09-25T18:50:11.474395001Z",
"startTime": "2022-09-25T18:55:32.633185Z",
"endTime": "2022-09-25T22:00:12.010069Z",
"updateTime": "2022-09-25T22:00:12.010069Z",
"status": "INFRA_FAILURE",
"statusDetails": {
"timeout": {
}
},
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "67aacac5158836027fa275a629502e166c78f70b",
"ref": "refs/heads/main"
}
}
}
[22:00:13.073] Invocation finished in 3h10m2.95551148s with status FAILED