[14:57:43.081] New invocation is queued and will start shortly
[14:57:44.161] Starting the invocation (attempt 1)
[14:57:44.192] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bd260982220a1ffa0d03b548c513dc0920d80a89"
[14:57:44.192] Popped gitiles commit info from properties and tags
[14:57:44.193] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:57:44.193] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:57:44.193] Buildbucket request:
{
"requestId": "8988035235595966176",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTiOSDevice"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "bd260982220a1ffa0d03b548c513dc0920d80a89",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8988035235595966176"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTiOSDevice"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[14:57:44.872] Scheduled build:
{
"id": "8822605173688883265",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTiOSDevice"
},
"number": 23884,
"createdBy": "project:chromium",
"createTime": "2022-02-10T14:57:44.268745998Z",
"updateTime": "2022-02-10T14:57:44.268745998Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "bd260982220a1ffa0d03b548c513dc0920d80a89",
"ref": "refs/heads/main"
}
}
}
[14:57:44.872] Task URL: https://cr-buildbucket.appspot.com/build/8822605173688883265
[14:57:44.872] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:2:0) after 2m27s
[15:00:11.896] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:2:0)
[15:00:11.921] Build status: SCHEDULED
[15:00:11.921] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:3:0) after 8m49s
[15:00:24.578] Received PubSub notification, asking Buildbucket for the build status
[15:00:24.606] Build status: STARTED
[15:09:01.000] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:3:0)
[15:09:01.151] Build status: STARTED
[15:09:01.151] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:5:0) after 1m21s
[15:10:22.285] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:5:0)
[15:10:22.309] Build status: STARTED
[15:10:22.309] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:6:0) after 1m53s
[15:12:15.470] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:6:0)
[15:12:15.546] Build status: STARTED
[15:12:15.546] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:7:0) after 4m29s
[15:16:44.567] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:7:0)
[15:16:44.652] Build status: STARTED
[15:16:44.652] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:8:0) after 3m23s
[15:20:07.661] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:8:0)
[15:20:07.688] Build status: STARTED
[15:20:07.688] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:9:0) after 3m3s
[15:23:10.717] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:9:0)
[15:23:10.744] Build status: STARTED
[15:23:10.744] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:10:0) after 5m40s
[15:28:50.882] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:10:0)
[15:28:51.075] Build status: STARTED
[15:28:51.075] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:11:0) after 3m18s
[15:32:09.103] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:11:0)
[15:32:09.152] Build status: STARTED
[15:32:09.152] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:12:0) after 9m43s
[15:41:52.225] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:12:0)
[15:41:52.266] Build status: STARTED
[15:41:52.266] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:13:0) after 7m23s
[15:49:15.387] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:13:0)
[15:49:15.417] Build status: STARTED
[15:49:15.417] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:14:0) after 7m31s
[15:56:46.541] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:14:0)
[15:56:46.565] Build status: STARTED
[15:56:46.565] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:15:0) after 3m20s
[16:00:06.594] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:15:0)
[16:00:06.660] Build status: STARTED
[16:00:06.660] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:16:0) after 2m14s
[16:02:20.687] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:16:0)
[16:02:20.715] Build status: STARTED
[16:02:20.715] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:17:0) after 6m3s
[16:08:23.916] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:17:0)
[16:08:23.941] Build status: STARTED
[16:08:23.941] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:18:0) after 5m1s
[16:13:25.104] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:18:0)
[16:13:25.193] Build status: STARTED
[16:13:25.193] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:19:0) after 6m30s
[16:19:55.307] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:19:0)
[16:19:55.336] Build status: STARTED
[16:19:55.336] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:20:0) after 9m4s
[16:28:59.387] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:20:0)
[16:28:59.409] Build status: STARTED
[16:28:59.409] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:21:0) after 7m57s
[16:36:56.437] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:21:0)
[16:36:56.469] Build status: STARTED
[16:36:56.469] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:22:0) after 6m58s
[16:43:54.542] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:22:0)
[16:43:54.564] Build status: STARTED
[16:43:54.564] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:23:0) after 3m35s
[16:47:29.600] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:23:0)
[16:47:29.652] Build status: STARTED
[16:47:29.652] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:24:0) after 5m8s
[16:52:37.704] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:24:0)
[16:52:37.761] Build status: STARTED
[16:52:37.761] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:25:0) after 4m35s
[16:57:12.809] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:25:0)
[16:57:12.844] Build status: STARTED
[16:57:12.844] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:26:0) after 2m37s
[16:59:49.949] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:26:0)
[16:59:50.156] Build status: STARTED
[16:59:50.156] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:27:0) after 8m56s
[17:08:46.392] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:27:0)
[17:08:46.439] Build status: STARTED
[17:08:46.439] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:28:0) after 9m5s
[17:17:51.444] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:28:0)
[17:17:51.463] Build status: STARTED
[17:17:51.463] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:29:0) after 1m36s
[17:19:27.597] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:29:0)
[17:19:27.629] Build status: STARTED
[17:19:27.629] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:30:0) after 5m39s
[17:25:06.656] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:30:0)
[17:25:06.683] Build status: STARTED
[17:25:06.683] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:31:0) after 9m5s
[17:34:11.722] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:31:0)
[17:34:11.779] Build status: STARTED
[17:34:11.779] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:32:0) after 8m57s
[17:43:08.792] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:32:0)
[17:43:08.813] Build status: STARTED
[17:43:08.813] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:33:0) after 4m23s
[17:47:31.860] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:33:0)
[17:47:31.899] Build status: STARTED
[17:47:31.899] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:34:0) after 5m28s
[17:52:59.922] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:34:0)
[17:52:59.968] Build status: STARTED
[17:52:59.968] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:35:0) after 5m51s
[17:58:51.092] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:35:0)
[17:58:51.134] Build status: STARTED
[17:58:51.134] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:36:0) after 6m6s
[18:04:57.120] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:36:0)
[18:04:57.147] Build status: STARTED
[18:04:57.147] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:37:0) after 8m48s
[18:13:45.496] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:37:0)
[18:13:45.519] Build status: STARTED
[18:13:45.519] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:38:0) after 7m7s
[18:20:52.976] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:38:0)
[18:20:53.002] Build status: STARTED
[18:20:53.002] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:39:0) after 6m36s
[18:27:29.237] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:39:0)
[18:27:29.535] Build status: STARTED
[18:27:29.535] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:40:0) after 5m45s
[18:33:14.689] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:40:0)
[18:33:14.712] Build status: STARTED
[18:33:14.712] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:41:0) after 7m51s
[18:41:05.908] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:41:0)
[18:41:05.943] Build status: STARTED
[18:41:05.943] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:42:0) after 6m48s
[18:47:54.027] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:42:0)
[18:47:54.065] Build status: STARTED
[18:47:54.065] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:43:0) after 2m36s
[18:50:30.062] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:43:0)
[18:50:30.190] Build status: STARTED
[18:50:30.190] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:44:0) after 8m45s
[18:59:15.270] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:44:0)
[18:59:15.294] Build status: STARTED
[18:59:15.294] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:45:0) after 3m52s
[19:03:07.456] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:45:0)
[19:03:07.548] Build status: STARTED
[19:03:07.548] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:46:0) after 9m30s
[19:12:37.600] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:46:0)
[19:12:37.627] Build status: STARTED
[19:12:37.627] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:47:0) after 5m1s
[19:17:38.705] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:47:0)
[19:17:38.777] Build status: STARTED
[19:17:38.777] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:48:0) after 4m30s
[19:22:08.901] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:48:0)
[19:22:08.952] Build status: STARTED
[19:22:08.952] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:49:0) after 6m21s
[19:28:30.176] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:49:0)
[19:28:30.264] Build status: STARTED
[19:28:30.264] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:50:0) after 4m14s
[19:32:44.320] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:50:0)
[19:32:44.344] Build status: STARTED
[19:32:44.344] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:51:0) after 5m58s
[19:38:42.710] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:51:0)
[19:38:42.739] Build status: STARTED
[19:38:42.739] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:52:0) after 1m4s
[19:39:46.778] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:52:0)
[19:39:46.800] Build status: STARTED
[19:39:46.800] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:53:0) after 4m11s
[19:43:58.000] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:53:0)
[19:43:58.023] Build status: STARTED
[19:43:58.023] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:54:0) after 3m2s
[19:47:00.114] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:54:0)
[19:47:00.311] Build status: STARTED
[19:47:00.311] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:55:0) after 4m4s
[19:51:04.726] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:55:0)
[19:51:04.768] Build status: STARTED
[19:51:04.768] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:56:0) after 6m26s
[19:57:30.793] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:56:0)
[19:57:30.829] Build status: STARTED
[19:57:30.829] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:57:0) after 3m20s
[20:00:50.833] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:57:0)
[20:00:50.875] Build status: STARTED
[20:00:50.875] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:58:0) after 8m59s
[20:09:49.905] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:58:0)
[20:09:49.931] Build status: STARTED
[20:09:49.931] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:59:0) after 3m58s
[20:13:48.350] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:59:0)
[20:13:48.378] Build status: STARTED
[20:13:48.378] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:60:0) after 9m1s
[20:22:49.771] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:60:0)
[20:22:49.799] Build status: STARTED
[20:22:49.799] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:61:0) after 8m47s
[20:31:37.030] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:61:0)
[20:31:37.049] Build status: STARTED
[20:31:37.049] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:62:0) after 8m57s
[20:40:34.125] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:62:0)
[20:40:34.178] Build status: STARTED
[20:40:34.178] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:63:0) after 5m24s
[20:45:58.280] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:63:0)
[20:45:58.303] Build status: STARTED
[20:45:58.303] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:64:0) after 4m21s
[20:50:19.409] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:64:0)
[20:50:19.437] Build status: STARTED
[20:50:19.437] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:65:0) after 5m59s
[20:56:18.466] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:65:0)
[20:56:18.627] Build status: STARTED
[20:56:18.627] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:66:0) after 2m9s
[20:58:27.775] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:66:0)
[20:58:27.798] Build status: STARTED
[20:58:27.798] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:67:0) after 2m13s
[21:00:40.829] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:67:0)
[21:00:40.857] Build status: STARTED
[21:00:40.857] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:68:0) after 3m40s
[21:04:20.905] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:68:0)
[21:04:20.932] Build status: STARTED
[21:04:20.932] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:69:0) after 3m29s
[21:07:50.227] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:69:0)
[21:07:50.253] Build status: STARTED
[21:07:50.253] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:70:0) after 1m54s
[21:09:44.555] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:70:0)
[21:09:44.580] Build status: STARTED
[21:09:44.580] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:71:0) after 6m6s
[21:15:50.686] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:71:0)
[21:15:50.745] Build status: STARTED
[21:15:50.745] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:72:0) after 8m40s
[21:24:30.868] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:72:0)
[21:24:30.898] Build status: STARTED
[21:24:30.898] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:73:0) after 2m43s
[21:27:14.100] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:73:0)
[21:27:14.124] Build status: STARTED
[21:27:14.124] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:74:0) after 1m59s
[21:29:13.154] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:74:0)
[21:29:13.177] Build status: STARTED
[21:29:13.177] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:75:0) after 7m58s
[21:37:11.205] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:75:0)
[21:37:11.230] Build status: STARTED
[21:37:11.230] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:76:0) after 3m22s
[21:40:33.242] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:76:0)
[21:40:33.264] Build status: STARTED
[21:40:33.264] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:77:0) after 3m23s
[21:43:56.286] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:77:0)
[21:43:56.310] Build status: STARTED
[21:43:56.310] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:78:0) after 1m21s
[21:45:17.439] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:78:0)
[21:45:17.460] Build status: STARTED
[21:45:17.460] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:79:0) after 6m21s
[21:51:38.623] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:79:0)
[21:51:38.696] Build status: STARTED
[21:51:38.696] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:80:0) after 1m15s
[21:52:53.725] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:80:0)
[21:52:53.750] Build status: STARTED
[21:52:53.750] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:81:0) after 1m34s
[21:54:28.031] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:81:0)
[21:54:28.063] Build status: STARTED
[21:54:28.063] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:82:0) after 2m30s
[21:56:58.147] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:82:0)
[21:56:58.171] Build status: STARTED
[21:56:58.171] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:83:0) after 6m30s
[22:03:28.485] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:83:0)
[22:03:28.510] Build status: STARTED
[22:03:28.510] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:84:0) after 4m43s
[22:08:11.640] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:84:0)
[22:08:11.658] Build status: STARTED
[22:08:11.658] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:85:0) after 8m57s
[22:17:08.687] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:85:0)
[22:17:12.664] Build status: STARTED
[22:17:12.664] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:86:0) after 2m29s
[22:19:41.738] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:86:0)
[22:19:48.101] Build status: STARTED
[22:19:48.101] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:87:0) after 3m13s
[22:23:01.146] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:87:0)
[22:23:01.182] Build status: STARTED
[22:23:01.182] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:88:0) after 7m4s
[22:30:05.291] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:88:0)
[22:30:05.310] Build status: STARTED
[22:30:05.310] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:89:0) after 7m44s
[22:37:49.643] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:89:0)
[22:37:49.664] Build status: STARTED
[22:37:49.664] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:90:0) after 9m41s
[22:47:30.724] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:90:0)
[22:47:30.746] Build status: STARTED
[22:47:30.746] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:91:0) after 7m56s
[22:55:26.771] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:91:0)
[22:55:26.796] Build status: STARTED
[22:55:26.796] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:92:0) after 1m32s
[22:56:58.918] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:92:0)
[22:56:59.207] Build status: STARTED
[22:56:59.207] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:93:0) after 7m34s
[23:04:33.404] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:93:0)
[23:04:33.426] Build status: STARTED
[23:04:33.426] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:94:0) after 3m19s
[23:07:52.452] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:94:0)
[23:07:52.698] Build status: STARTED
[23:07:52.698] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:95:0) after 8m11s
[23:16:03.728] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:95:0)
[23:16:03.766] Build status: STARTED
[23:16:03.766] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:96:0) after 1m2s
[23:17:05.903] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:96:0)
[23:17:05.923] Build status: STARTED
[23:17:05.923] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:97:0) after 5m9s
[23:22:14.974] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:97:0)
[23:22:14.997] Build status: STARTED
[23:22:14.997] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:98:0) after 1m13s
[23:23:28.107] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:98:0)
[23:23:28.183] Build status: STARTED
[23:23:28.184] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:99:0) after 8m42s
[23:32:10.254] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:99:0)
[23:32:10.283] Build status: STARTED
[23:32:10.283] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:100:0) after 3m36s
[23:35:46.356] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:100:0)
[23:35:46.380] Build status: STARTED
[23:35:46.380] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:101:0) after 7m38s
[23:43:24.639] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:101:0)
[23:43:24.660] Build status: STARTED
[23:43:24.660] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:102:0) after 5m58s
[23:49:22.753] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:102:0)
[23:49:22.829] Build status: STARTED
[23:49:22.829] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:103:0) after 2m28s
[23:51:50.855] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:103:0)
[23:51:50.893] Build status: STARTED
[23:51:50.893] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:104:0) after 4m13s
[23:56:03.922] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:104:0)
[23:56:03.942] Build status: STARTED
[23:56:03.942] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:105:0) after 5m44s
[00:01:48.075] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:105:0)
[00:01:48.096] Build status: STARTED
[00:01:48.096] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:106:0) after 5m40s
[00:07:28.470] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:106:0)
[00:07:28.490] Build status: STARTED
[00:07:28.490] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:107:0) after 1m5s
[00:08:33.649] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:107:0)
[00:08:33.753] Build status: STARTED
[00:08:33.753] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:108:0) after 2m18s
[00:10:51.805] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:108:0)
[00:10:51.824] Build status: STARTED
[00:10:51.824] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:109:0) after 4m42s
[00:15:34.020] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:109:0)
[00:15:34.045] Build status: STARTED
[00:15:34.046] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:110:0) after 9m10s
[00:24:44.526] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:110:0)
[00:24:44.573] Build status: STARTED
[00:24:44.573] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:111:0) after 4m7s
[00:28:51.635] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:111:0)
[00:28:51.669] Build status: STARTED
[00:28:51.669] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:8988035235595966176:112:0) after 2m1s
[00:29:45.352] Received PubSub notification, asking Buildbucket for the build status
[00:29:45.378] Build:
{
"id": "8822605173688883265",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTiOSDevice"
},
"number": 23884,
"createdBy": "project:chromium",
"createTime": "2022-02-10T14:57:44.268745998Z",
"startTime": "2022-02-10T15:00:21.376484Z",
"endTime": "2022-02-11T00:29:45.010124222Z",
"updateTime": "2022-02-11T00:29:45.010124222Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "bd260982220a1ffa0d03b548c513dc0920d80a89",
"ref": "refs/heads/main"
}
}
}
[00:29:45.378] Invocation finished in 9h32m2.312777891s with status FAILED